builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1461584801.0 results: success (0) buildid: 20160422035709 builduid: 3af33a9a7de54ba3986a82f34ab86caa revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:40.997456) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:40.997812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:40.998074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.482785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.483045) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 04:46:42-- 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% 220M=0s 2016-04-25 04:46:42 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126493 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.636414) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.636696) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.686076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.686390) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80598be5d80e695727ff74e712faa623b02f3c70 --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 80598be5d80e695727ff74e712faa623b02f3c70 --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=97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 04:46:42,518 truncating revision to first 12 chars 2016-04-25 04:46:42,518 Setting DEBUG logging. 2016-04-25 04:46:42,518 attempt 1/10 2016-04-25 04:46:42,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80598be5d80e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 04:46:42,819 unpacking tar archive at: fx-team-80598be5d80e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.272403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.272664) ========= script_repo_revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.273044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.273300) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.284286) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-25 04:46:42.284546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:46:43 INFO - MultiFileLogger online at 20160425 04:46:43 in /builds/slave/test 04:46:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:46:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:43 INFO - {'append_to_log': False, 04:46:43 INFO - 'base_work_dir': '/builds/slave/test', 04:46:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:46:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:43 INFO - 'branch': 'Fx-Team-Non-PGO', 04:46:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:43 INFO - 'config_files': ('talos/linux_config.py',), 04:46:43 INFO - 'default_actions': ('clobber', 04:46:43 INFO - 'read-buildbot-config', 04:46:43 INFO - 'download-and-extract', 04:46:43 INFO - 'populate-webroot', 04:46:43 INFO - 'create-virtualenv', 04:46:43 INFO - 'install', 04:46:43 INFO - 'run-tests'), 04:46:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:43 INFO - 'download_minidump_stackwalk': True, 04:46:43 INFO - 'download_symbols': 'ondemand', 04:46:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:43 INFO - 'installer_path': 'installer.exe', 04:46:43 INFO - 'log_level': 'info', 04:46:43 INFO - 'log_name': 'talos', 04:46:43 INFO - 'log_to_console': True, 04:46:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:46:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:46:43 INFO - 'opt_config_files': (), 04:46:43 INFO - 'pip_index': False, 04:46:43 INFO - 'sps_profile': False, 04:46:43 INFO - 'sps_profile_interval': 0, 04:46:43 INFO - 'suite': 'dromaeojs', 04:46:43 INFO - 'system_bits': '32', 04:46:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:43 INFO - 'title': 'talos-linux64-ix-068', 04:46:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:43 INFO - 'use_talos_json': True, 04:46:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:43 INFO - 'work_dir': 'build'} 04:46:43 INFO - ##### 04:46:43 INFO - ##### Running clobber step. 04:46:43 INFO - ##### 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: clobber 04:46:43 INFO - rmtree: /builds/slave/test/build 04:46:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:43 INFO - Running post-action listener: _resource_record_post_action 04:46:43 INFO - ##### 04:46:43 INFO - ##### Running read-buildbot-config step. 04:46:43 INFO - ##### 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: read_buildbot_config 04:46:43 INFO - Using buildbot properties: 04:46:43 INFO - { 04:46:43 INFO - "project": "", 04:46:43 INFO - "product": "firefox", 04:46:43 INFO - "script_repo_revision": "production", 04:46:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:46:43 INFO - "repository": "", 04:46:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:46:43 INFO - "buildid": "20160422035709", 04:46:43 INFO - "pgo_build": "False", 04:46:43 INFO - "basedir": "/builds/slave/test", 04:46:43 INFO - "buildnumber": 2877, 04:46:43 INFO - "slavename": "talos-linux64-ix-068", 04:46:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:46:43 INFO - "platform": "ubuntu64_hw", 04:46:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:46:43 INFO - "branch": "fx-team", 04:46:43 INFO - "repo_path": "integration/fx-team", 04:46:43 INFO - "revision": "80598be5d80e695727ff74e712faa623b02f3c70", 04:46:43 INFO - "stage_platform": "linux64", 04:46:43 INFO - "builduid": "3af33a9a7de54ba3986a82f34ab86caa", 04:46:43 INFO - "slavebuilddir": "test" 04:46:43 INFO - } 04:46:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:46:43 INFO - Running post-action listener: _resource_record_post_action 04:46:43 INFO - ##### 04:46:43 INFO - ##### Running download-and-extract step. 04:46:43 INFO - ##### 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: download_and_extract 04:46:43 INFO - mkdir: /builds/slave/test/build/tests 04:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:43 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:46:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:46:47 INFO - Downloaded 1361 bytes. 04:46:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:47 INFO - Using the following test package requirements: 04:46:47 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:46:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:46:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:47 INFO - u'jsshell-linux-x86_64.zip'], 04:46:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:46:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:46:47 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:46:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:46:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:46:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:47 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:46:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:46:52 INFO - Downloaded 22281373 bytes. 04:46:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:46:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:46:54 INFO - Return code: 0 04:46:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:54 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:46:55 INFO - Downloaded 22281373 bytes. 04:46:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:46:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:46:56 INFO - Return code: 0 04:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:56 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:46:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:46:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:46:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:46:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:46:58 INFO - Downloaded 10845952 bytes. 04:46:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:46:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:46:58 INFO - Return code: 0 04:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:58 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:47:00 INFO - Downloaded 54650321 bytes. 04:47:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:47:00 INFO - mkdir: /builds/slave/test/properties 04:47:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:00 INFO - Contents: 04:47:00 INFO - build_url:https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:47:01 INFO - Running post-action listener: _resource_record_post_action 04:47:01 INFO - Running post-action listener: set_extra_try_arguments 04:47:01 INFO - ##### 04:47:01 INFO - ##### Running populate-webroot step. 04:47:01 INFO - ##### 04:47:01 INFO - Running pre-action listener: _resource_record_pre_action 04:47:01 INFO - Running main action method: populate_webroot 04:47:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:01 INFO - '--tppagecycles', 04:47:01 INFO - '7'], 04:47:01 INFO - 'tests': ['tsvgm']}}, 04:47:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:01 INFO - 'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:01 INFO - 'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['damp', 'tps']}, 04:47:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:01 INFO - 'tests': ['damp', 'tps']}, 04:47:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['dromaeo_dom']}, 04:47:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['a11yr', 04:47:01 INFO - 'ts_paint', 04:47:01 INFO - 'tpaint', 04:47:01 INFO - 'sessionrestore', 04:47:01 INFO - 'sessionrestore_no_auto_restore', 04:47:01 INFO - 'tabpaint']}, 04:47:01 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:01 INFO - 'ts_paint', 04:47:01 INFO - 'tpaint', 04:47:01 INFO - 'sessionrestore', 04:47:01 INFO - 'sessionrestore_no_auto_restore', 04:47:01 INFO - 'tabpaint']}, 04:47:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:01 INFO - 'ts_paint', 04:47:01 INFO - 'tpaint', 04:47:01 INFO - 'sessionrestore', 04:47:01 INFO - 'sessionrestore_no_auto_restore', 04:47:01 INFO - 'tabpaint']}, 04:47:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:01 INFO - 'ts_paint', 04:47:01 INFO - 'tpaint', 04:47:01 INFO - 'sessionrestore', 04:47:01 INFO - 'sessionrestore_no_auto_restore', 04:47:01 INFO - 'tabpaint']}, 04:47:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['a11yr', 04:47:01 INFO - 'ts_paint', 04:47:01 INFO - 'tpaint', 04:47:01 INFO - 'sessionrestore', 04:47:01 INFO - 'sessionrestore_no_auto_restore', 04:47:01 INFO - 'tabpaint']}, 04:47:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['a11yr', 04:47:01 INFO - 'ts_paint', 04:47:01 INFO - 'tpaint', 04:47:01 INFO - 'sessionrestore', 04:47:01 INFO - 'sessionrestore_no_auto_restore', 04:47:01 INFO - 'tabpaint']}, 04:47:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['tsvgx', 04:47:01 INFO - 'tsvgr_opacity', 04:47:01 INFO - 'tart', 04:47:01 INFO - 'tscrollx', 04:47:01 INFO - 'cart']}, 04:47:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:01 INFO - 'tsvgr_opacity', 04:47:01 INFO - 'tart', 04:47:01 INFO - 'tscrollx', 04:47:01 INFO - 'cart']}, 04:47:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:01 INFO - 'talos_options': ['--disable-e10s'], 04:47:01 INFO - 'tests': ['tp5o']}, 04:47:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:01 INFO - 'tests': ['tp5o']}, 04:47:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:01 INFO - 'talos_options': ['--disable-e10s', 04:47:01 INFO - '--xperf_path', 04:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:01 INFO - 'tests': ['tp5n']}, 04:47:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:01 INFO - 'talos_options': ['--xperf_path', 04:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:01 INFO - 'tests': ['tp5n']}}, 04:47:01 INFO - 'talos.zip': {'path': '', 04:47:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:01 INFO - Running post-action listener: _resource_record_post_action 04:47:01 INFO - ##### 04:47:01 INFO - ##### Running create-virtualenv step. 04:47:01 INFO - ##### 04:47:01 INFO - Running pre-action listener: _resource_record_pre_action 04:47:01 INFO - Running main action method: create_virtualenv 04:47:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:47:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:01 INFO - Using real prefix '/usr' 04:47:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:03 INFO - Installing pip.................done. 04:47:03 INFO - Return code: 0 04:47:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:03 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 0x7face9a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:47:03 INFO - Using env: {'DISPLAY': ':0', 04:47:03 INFO - 'HOME': '/home/cltbld', 04:47:03 INFO - 'LANG': 'en_US.UTF-8', 04:47:03 INFO - 'LANGUAGE': 'en_US:en', 04:47:03 INFO - 'LOGNAME': 'cltbld', 04:47:03 INFO - 'MAIL': '/var/mail/cltbld', 04:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:03 INFO - 'MOZ_NO_REMOTE': '1', 04:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:03 INFO - 'NO_EM_RESTART': '1', 04:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:03 INFO - 'PWD': '/builds/slave/test', 04:47:03 INFO - 'SHELL': '/bin/bash', 04:47:03 INFO - 'SHLVL': '1', 04:47:03 INFO - 'TERM': 'linux', 04:47:03 INFO - 'TMOUT': '86400', 04:47:03 INFO - 'USER': 'cltbld', 04:47:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:03 INFO - '_': '/tools/buildbot/bin/python'} 04:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:47:03 INFO - Cleaning up... 04:47:03 INFO - Return code: 0 04:47:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:47:03 INFO - Using env: {'DISPLAY': ':0', 04:47:03 INFO - 'HOME': '/home/cltbld', 04:47:03 INFO - 'LANG': 'en_US.UTF-8', 04:47:03 INFO - 'LANGUAGE': 'en_US:en', 04:47:03 INFO - 'LOGNAME': 'cltbld', 04:47:03 INFO - 'MAIL': '/var/mail/cltbld', 04:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:03 INFO - 'MOZ_NO_REMOTE': '1', 04:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:03 INFO - 'NO_EM_RESTART': '1', 04:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:03 INFO - 'PWD': '/builds/slave/test', 04:47:03 INFO - 'SHELL': '/bin/bash', 04:47:03 INFO - 'SHLVL': '1', 04:47:03 INFO - 'TERM': 'linux', 04:47:03 INFO - 'TMOUT': '86400', 04:47:03 INFO - 'USER': 'cltbld', 04:47:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:03 INFO - '_': '/tools/buildbot/bin/python'} 04:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:04 INFO - Downloading/unpacking psutil>=0.7.1 04:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:06 INFO - Installing collected packages: psutil 04:47:06 INFO - Running setup.py install for psutil 04:47:06 INFO - building 'psutil._psutil_linux' extension 04:47:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:47:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:47:06 INFO - building 'psutil._psutil_posix' extension 04:47:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:47:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:06 INFO - Successfully installed psutil 04:47:06 INFO - Cleaning up... 04:47:06 INFO - Return code: 0 04:47:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face9a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:47:06 INFO - Using env: {'DISPLAY': ':0', 04:47:06 INFO - 'HOME': '/home/cltbld', 04:47:06 INFO - 'LANG': 'en_US.UTF-8', 04:47:06 INFO - 'LANGUAGE': 'en_US:en', 04:47:06 INFO - 'LOGNAME': 'cltbld', 04:47:06 INFO - 'MAIL': '/var/mail/cltbld', 04:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:06 INFO - 'MOZ_NO_REMOTE': '1', 04:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:06 INFO - 'NO_EM_RESTART': '1', 04:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:06 INFO - 'PWD': '/builds/slave/test', 04:47:06 INFO - 'SHELL': '/bin/bash', 04:47:06 INFO - 'SHLVL': '1', 04:47:06 INFO - 'TERM': 'linux', 04:47:06 INFO - 'TMOUT': '86400', 04:47:06 INFO - 'USER': 'cltbld', 04:47:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:06 INFO - '_': '/tools/buildbot/bin/python'} 04:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:47:09 INFO - Installing collected packages: mozsystemmonitor 04:47:09 INFO - Running setup.py install for mozsystemmonitor 04:47:09 INFO - Successfully installed mozsystemmonitor 04:47:09 INFO - Cleaning up... 04:47:09 INFO - Return code: 0 04:47:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:09 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 0x7face9a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:09 INFO - Using env: {'DISPLAY': ':0', 04:47:09 INFO - 'HOME': '/home/cltbld', 04:47:09 INFO - 'LANG': 'en_US.UTF-8', 04:47:09 INFO - 'LANGUAGE': 'en_US:en', 04:47:09 INFO - 'LOGNAME': 'cltbld', 04:47:09 INFO - 'MAIL': '/var/mail/cltbld', 04:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:09 INFO - 'MOZ_NO_REMOTE': '1', 04:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:09 INFO - 'NO_EM_RESTART': '1', 04:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:09 INFO - 'PWD': '/builds/slave/test', 04:47:09 INFO - 'SHELL': '/bin/bash', 04:47:09 INFO - 'SHLVL': '1', 04:47:09 INFO - 'TERM': 'linux', 04:47:09 INFO - 'TMOUT': '86400', 04:47:09 INFO - 'USER': 'cltbld', 04:47:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:09 INFO - '_': '/tools/buildbot/bin/python'} 04:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:11 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:11 INFO - Downloading docopt-0.6.1.tar.gz 04:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:12 INFO - Running setup.py install for blobuploader 04:47:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:12 INFO - Running setup.py install for requests 04:47:12 INFO - Running setup.py install for docopt 04:47:12 INFO - Successfully installed blobuploader requests docopt 04:47:12 INFO - Cleaning up... 04:47:12 INFO - Return code: 0 04:47:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 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 0x7face9a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:12 INFO - Using env: {'DISPLAY': ':0', 04:47:12 INFO - 'HOME': '/home/cltbld', 04:47:12 INFO - 'LANG': 'en_US.UTF-8', 04:47:12 INFO - 'LANGUAGE': 'en_US:en', 04:47:12 INFO - 'LOGNAME': 'cltbld', 04:47:12 INFO - 'MAIL': '/var/mail/cltbld', 04:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:12 INFO - 'MOZ_NO_REMOTE': '1', 04:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:12 INFO - 'NO_EM_RESTART': '1', 04:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:12 INFO - 'PWD': '/builds/slave/test', 04:47:12 INFO - 'SHELL': '/bin/bash', 04:47:12 INFO - 'SHLVL': '1', 04:47:12 INFO - 'TERM': 'linux', 04:47:12 INFO - 'TMOUT': '86400', 04:47:12 INFO - 'USER': 'cltbld', 04:47:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:12 INFO - '_': '/tools/buildbot/bin/python'} 04:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:12 INFO - Running setup.py (path:/tmp/pip-MQDrF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:12 INFO - Running setup.py (path:/tmp/pip-exxJE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:13 INFO - Running setup.py (path:/tmp/pip-Xwv1vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:13 INFO - Running setup.py (path:/tmp/pip-UBJyz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:13 INFO - Running setup.py (path:/tmp/pip-LJBhwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:13 INFO - Running setup.py (path:/tmp/pip-fOdxGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:13 INFO - Running setup.py (path:/tmp/pip-a84VfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:13 INFO - Running setup.py (path:/tmp/pip-qSyadr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:13 INFO - Running setup.py (path:/tmp/pip-QbFkFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:13 INFO - Running setup.py (path:/tmp/pip-2Eq2qB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:13 INFO - Running setup.py (path:/tmp/pip-sp9yfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:13 INFO - Running setup.py (path:/tmp/pip-gQ2tyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:13 INFO - Running setup.py (path:/tmp/pip-1BGMBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:13 INFO - Running setup.py (path:/tmp/pip-_f82om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:13 INFO - Running setup.py (path:/tmp/pip-YwUbdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:13 INFO - Running setup.py (path:/tmp/pip-Xfi7R0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:14 INFO - Running setup.py (path:/tmp/pip-_HLJsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:14 INFO - Running setup.py install for manifestparser 04:47:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:14 INFO - Running setup.py install for mozcrash 04:47:14 INFO - Running setup.py install for mozdebug 04:47:14 INFO - Running setup.py install for mozdevice 04:47:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:14 INFO - Running setup.py install for mozfile 04:47:14 INFO - Running setup.py install for mozhttpd 04:47:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:14 INFO - Running setup.py install for mozinfo 04:47:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:14 INFO - Running setup.py install for mozInstall 04:47:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:14 INFO - Running setup.py install for mozleak 04:47:15 INFO - Running setup.py install for mozlog 04:47:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for moznetwork 04:47:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozprocess 04:47:15 INFO - Running setup.py install for mozprofile 04:47:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozrunner 04:47:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozscreenshot 04:47:15 INFO - Running setup.py install for moztest 04:47:15 INFO - Running setup.py install for mozversion 04:47:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:15 INFO - Cleaning up... 04:47:15 INFO - Return code: 0 04:47:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:15 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 0x7face9a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:15 INFO - Using env: {'DISPLAY': ':0', 04:47:15 INFO - 'HOME': '/home/cltbld', 04:47:15 INFO - 'LANG': 'en_US.UTF-8', 04:47:15 INFO - 'LANGUAGE': 'en_US:en', 04:47:15 INFO - 'LOGNAME': 'cltbld', 04:47:15 INFO - 'MAIL': '/var/mail/cltbld', 04:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:15 INFO - 'MOZ_NO_REMOTE': '1', 04:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:15 INFO - 'NO_EM_RESTART': '1', 04:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:15 INFO - 'PWD': '/builds/slave/test', 04:47:15 INFO - 'SHELL': '/bin/bash', 04:47:15 INFO - 'SHLVL': '1', 04:47:15 INFO - 'TERM': 'linux', 04:47:15 INFO - 'TMOUT': '86400', 04:47:15 INFO - 'USER': 'cltbld', 04:47:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:15 INFO - '_': '/tools/buildbot/bin/python'} 04:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:16 INFO - Running setup.py (path:/tmp/pip-NZ_08A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:16 INFO - Running setup.py (path:/tmp/pip-NIEGHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:16 INFO - Running setup.py (path:/tmp/pip-sXLgF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:16 INFO - Running setup.py (path:/tmp/pip-oHzQPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:16 INFO - Running setup.py (path:/tmp/pip-9PBULw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:16 INFO - Running setup.py (path:/tmp/pip-HWpftw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:16 INFO - Running setup.py (path:/tmp/pip-030OyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:16 INFO - Running setup.py (path:/tmp/pip-3n6W19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:16 INFO - Running setup.py (path:/tmp/pip-OBYIV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:16 INFO - Running setup.py (path:/tmp/pip-4W5D2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:16 INFO - Running setup.py (path:/tmp/pip-eYURYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:16 INFO - Running setup.py (path:/tmp/pip-noC5nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:17 INFO - Running setup.py (path:/tmp/pip-LGVk5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:17 INFO - Running setup.py (path:/tmp/pip-2iV7ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:17 INFO - Running setup.py (path:/tmp/pip-T0UFax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:17 INFO - Running setup.py (path:/tmp/pip-53ZTFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:17 INFO - Running setup.py (path:/tmp/pip-kO2JGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:19 INFO - Downloading blessings-1.6.tar.gz 04:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:19 INFO - Installing collected packages: blessings 04:47:19 INFO - Running setup.py install for blessings 04:47:19 INFO - Successfully installed blessings 04:47:19 INFO - Cleaning up... 04:47:19 INFO - Return code: 0 04:47:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:19 INFO - Reading from file tmpfile_stdout 04:47:19 INFO - Current package versions: 04:47:19 INFO - argparse == 1.2.1 04:47:19 INFO - blessings == 1.6 04:47:19 INFO - blobuploader == 1.2.4 04:47:19 INFO - docopt == 0.6.1 04:47:19 INFO - manifestparser == 1.1 04:47:19 INFO - mozInstall == 1.12 04:47:19 INFO - mozcrash == 0.17 04:47:19 INFO - mozdebug == 0.1 04:47:19 INFO - mozdevice == 0.48 04:47:19 INFO - mozfile == 1.2 04:47:19 INFO - mozhttpd == 0.7 04:47:19 INFO - mozinfo == 0.9 04:47:19 INFO - mozleak == 0.1 04:47:19 INFO - mozlog == 3.1 04:47:19 INFO - moznetwork == 0.27 04:47:19 INFO - mozprocess == 0.22 04:47:19 INFO - mozprofile == 0.28 04:47:19 INFO - mozrunner == 6.11 04:47:19 INFO - mozscreenshot == 0.1 04:47:19 INFO - mozsystemmonitor == 0.0 04:47:19 INFO - moztest == 0.7 04:47:19 INFO - mozversion == 1.4 04:47:19 INFO - psutil == 3.1.1 04:47:19 INFO - requests == 1.2.3 04:47:19 INFO - wsgiref == 0.1.2 04:47:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:19 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 0x7face9a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:19 INFO - Using env: {'DISPLAY': ':0', 04:47:19 INFO - 'HOME': '/home/cltbld', 04:47:19 INFO - 'LANG': 'en_US.UTF-8', 04:47:19 INFO - 'LANGUAGE': 'en_US:en', 04:47:19 INFO - 'LOGNAME': 'cltbld', 04:47:19 INFO - 'MAIL': '/var/mail/cltbld', 04:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:19 INFO - 'MOZ_NO_REMOTE': '1', 04:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:19 INFO - 'NO_EM_RESTART': '1', 04:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:19 INFO - 'PWD': '/builds/slave/test', 04:47:19 INFO - 'SHELL': '/bin/bash', 04:47:19 INFO - 'SHLVL': '1', 04:47:19 INFO - 'TERM': 'linux', 04:47:19 INFO - 'TMOUT': '86400', 04:47:19 INFO - 'USER': 'cltbld', 04:47:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:19 INFO - '_': '/tools/buildbot/bin/python'} 04:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:47:19 INFO - Cleaning up... 04:47:19 INFO - Return code: 0 04:47:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:19 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 0x7face9a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:47:19 INFO - Using env: {'DISPLAY': ':0', 04:47:19 INFO - 'HOME': '/home/cltbld', 04:47:19 INFO - 'LANG': 'en_US.UTF-8', 04:47:19 INFO - 'LANGUAGE': 'en_US:en', 04:47:19 INFO - 'LOGNAME': 'cltbld', 04:47:19 INFO - 'MAIL': '/var/mail/cltbld', 04:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:19 INFO - 'MOZ_NO_REMOTE': '1', 04:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:19 INFO - 'NO_EM_RESTART': '1', 04:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:19 INFO - 'PWD': '/builds/slave/test', 04:47:19 INFO - 'SHELL': '/bin/bash', 04:47:19 INFO - 'SHLVL': '1', 04:47:19 INFO - 'TERM': 'linux', 04:47:19 INFO - 'TMOUT': '86400', 04:47:19 INFO - 'USER': 'cltbld', 04:47:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:19 INFO - '_': '/tools/buildbot/bin/python'} 04:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:20 INFO - Downloading/unpacking jsonschema 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:22 INFO - Downloading/unpacking functools32 (from jsonschema) 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:22 INFO - warning: no files found matching '*.txt' 04:47:22 INFO - no previously-included directories found matching 'build' 04:47:22 INFO - no previously-included directories found matching 'dist' 04:47:22 INFO - no previously-included directories found matching '.git*' 04:47:22 INFO - Installing collected packages: jsonschema, functools32 04:47:22 INFO - Running setup.py install for functools32 04:47:22 INFO - warning: no files found matching '*.txt' 04:47:22 INFO - no previously-included directories found matching 'build' 04:47:22 INFO - no previously-included directories found matching 'dist' 04:47:22 INFO - no previously-included directories found matching '.git*' 04:47:22 INFO - Successfully installed jsonschema functools32 04:47:22 INFO - Cleaning up... 04:47:22 INFO - Return code: 0 04:47:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:22 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 0x7face9a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:47:22 INFO - Using env: {'DISPLAY': ':0', 04:47:22 INFO - 'HOME': '/home/cltbld', 04:47:22 INFO - 'LANG': 'en_US.UTF-8', 04:47:22 INFO - 'LANGUAGE': 'en_US:en', 04:47:22 INFO - 'LOGNAME': 'cltbld', 04:47:22 INFO - 'MAIL': '/var/mail/cltbld', 04:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:22 INFO - 'MOZ_NO_REMOTE': '1', 04:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:22 INFO - 'NO_EM_RESTART': '1', 04:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:22 INFO - 'PWD': '/builds/slave/test', 04:47:22 INFO - 'SHELL': '/bin/bash', 04:47:22 INFO - 'SHLVL': '1', 04:47:22 INFO - 'TERM': 'linux', 04:47:22 INFO - 'TMOUT': '86400', 04:47:22 INFO - 'USER': 'cltbld', 04:47:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:22 INFO - '_': '/tools/buildbot/bin/python'} 04:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:22 INFO - Downloading/unpacking flake8 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:47:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:47:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:47:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:25 INFO - no previously-included directories found matching 'docs/_build' 04:47:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:47:25 INFO - Running setup.py install for pep8 04:47:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:25 INFO - no previously-included directories found matching 'docs/_build' 04:47:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:47:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:47:25 INFO - Cleaning up... 04:47:25 INFO - Return code: 0 04:47:25 INFO - Running post-action listener: _resource_record_post_action 04:47:25 INFO - Running post-action listener: _start_resource_monitoring 04:47:25 INFO - Starting resource monitoring. 04:47:25 INFO - ##### 04:47:25 INFO - ##### Running install step. 04:47:25 INFO - ##### 04:47:25 INFO - Running pre-action listener: _resource_record_pre_action 04:47:25 INFO - Running main action method: install 04:47:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:25 INFO - Reading from file tmpfile_stdout 04:47:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:25 INFO - Reading from file tmpfile_stdout 04:47:25 INFO - Output received: 04:47:25 INFO - Usage: mozinstall [options] installer 04:47:25 INFO - Options: 04:47:25 INFO - -h, --help show this help message and exit 04:47:25 INFO - -d DEST, --destination=DEST 04:47:25 INFO - Directory to install application into. [default: 04:47:25 INFO - "/builds/slave/test"] 04:47:25 INFO - --app=APP Application being installed. [default: firefox] 04:47:25 INFO - mkdir: /builds/slave/test/build/application 04:47:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:47:41 INFO - Reading from file tmpfile_stdout 04:47:41 INFO - Output received: 04:47:41 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:41 INFO - Running post-action listener: _resource_record_post_action 04:47:41 INFO - ##### 04:47:41 INFO - ##### Running run-tests step. 04:47:41 INFO - ##### 04:47:41 INFO - Running pre-action listener: _resource_record_pre_action 04:47:41 INFO - Running main action method: run_tests 04:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:41 INFO - Python 2.7.3 04:47:41 INFO - Return code: 0 04:47:41 INFO - grabbing minidump binary from tooltool 04:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d410>, '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 0x182e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x182e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:47:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:47:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:41 INFO - Return code: 0 04:47:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:47:42 INFO - Return code: 0 04:47:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:47:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:47:42 INFO - Using env: {'DISPLAY': ':0', 04:47:42 INFO - 'HOME': '/home/cltbld', 04:47:42 INFO - 'LANG': 'en_US.UTF-8', 04:47:42 INFO - 'LANGUAGE': 'en_US:en', 04:47:42 INFO - 'LOGNAME': 'cltbld', 04:47:42 INFO - 'MAIL': '/var/mail/cltbld', 04:47:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:42 INFO - 'MOZ_NO_REMOTE': '1', 04:47:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:42 INFO - 'NO_EM_RESTART': '1', 04:47:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:42 INFO - 'PWD': '/builds/slave/test', 04:47:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:42 INFO - 'SHELL': '/bin/bash', 04:47:42 INFO - 'SHLVL': '1', 04:47:42 INFO - 'TERM': 'linux', 04:47:42 INFO - 'TMOUT': '86400', 04:47:42 INFO - 'USER': 'cltbld', 04:47:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281', 04:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:42 INFO - '_': '/tools/buildbot/bin/python'} 04:47:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:47:42 INFO - mozversion application_buildid: 20160422035709 04:47:42 INFO - mozversion application_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:47:42 INFO - mozversion application_display_name: Nightly 04:47:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:42 INFO - mozversion application_name: Firefox 04:47:42 INFO - mozversion application_remotingname: firefox 04:47:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:47:42 INFO - mozversion application_vendor: Mozilla 04:47:42 INFO - mozversion application_version: 48.0a1 04:47:42 INFO - mozversion platform_buildid: 20160422035709 04:47:42 INFO - mozversion platform_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:47:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:47:42 INFO - mozversion platform_version: 48.0a1 04:47:42 INFO - using testdate: 1461584862 04:47:42 INFO - actual date: 1461584862 04:47:42 INFO - starting webserver on 'localhost:53084' 04:47:42 INFO - SUITE-START | Running 2 tests 04:47:42 INFO - TEST-START | dromaeo_css 04:47:42 INFO - operating with platform_type : linux_ 04:47:42 INFO - Initialising browser for dromaeo_css test... 04:47:42 INFO - TEST-INFO | started process 24014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplk5WKd/profile http://localhost:53084/getInfo.html) 04:47:47 INFO - PROCESS | 24014 | __metrics Screen width/height:1600/1200 04:47:47 INFO - PROCESS | 24014 | colorDepth:24 04:47:47 INFO - PROCESS | 24014 | Browser inner width/height: 1024/697 04:47:47 INFO - PROCESS | 24014 | __metrics 04:47:48 ERROR - PROCESS | 24014 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:47:49 INFO - TEST-INFO | 24014: exit 0 04:47:49 INFO - Browser initialized. 04:47:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:49 INFO - TEST-INFO | started process 24094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplk5WKd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:01 INFO - PROCESS | 24094 | RSS: Main: 155643904 04:48:01 INFO - PROCESS | 24094 | 04:48:53 INFO - PROCESS | 24094 | 1461584933085 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:51:04 INFO - PROCESS | 24094 | Cycle 1(1): loaded http://localhost:53084/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53084/tests/dromaeo/cssquery-ext.html) 04:51:05 INFO - PROCESS | 24094 | RSS: Main: 261410816 04:51:05 INFO - PROCESS | 24094 | 04:54:07 INFO - PROCESS | 24094 | Cycle 1(1): loaded http://localhost:53084/tests/dromaeo/cssquery-ext.html (next: http://localhost:53084/tests/dromaeo/cssquery-jquery.html) 04:54:08 INFO - PROCESS | 24094 | RSS: Main: 234057728 04:54:08 INFO - PROCESS | 24094 | 04:57:10 INFO - PROCESS | 24094 | Cycle 1(1): loaded http://localhost:53084/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53084/tests/dromaeo/cssquery-mootools.html) 04:57:11 INFO - PROCESS | 24094 | RSS: Main: 226807808 04:57:11 INFO - PROCESS | 24094 | 05:00:13 INFO - PROCESS | 24094 | Cycle 1(1): loaded http://localhost:53084/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53084/tests/dromaeo/cssquery-prototype.html) 05:00:13 INFO - PROCESS | 24094 | RSS: Main: 227254272 05:00:13 INFO - PROCESS | 24094 | 05:03:16 INFO - PROCESS | 24094 | Cycle 1(1): loaded http://localhost:53084/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53084/tests/dromaeo/cssquery-yui.html) 05:03:17 INFO - PROCESS | 24094 | RSS: Main: 215097344 05:03:17 INFO - PROCESS | 24094 | 05:06:20 INFO - PROCESS | 24094 | Cycle 1(1): loaded http://localhost:53084/tests/dromaeo/cssquery-yui.html (next: http://localhost:53084/tests/dromaeo/cssquery-dojo.html) 05:06:20 INFO - PROCESS | 24094 | RSS: Main: 270835712 05:06:20 INFO - PROCESS | 24094 | 05:06:20 INFO - PROCESS | 24094 | __start_tp_report 05:06:20 INFO - PROCESS | 24094 | _x_x_mozilla_page_load 05:06:20 INFO - PROCESS | 24094 | _x_x_mozilla_page_load_details 05:06:20 INFO - PROCESS | 24094 | |i|pagename|runs| 05:06:20 INFO - PROCESS | 24094 | |0;dojo.html;2576.6392705021294;2637.643918071061;2659.534581448246;2672.5723884178537;2686.7716244119256;4581.289900065487;4605.953940460595;4617.884552886179;4639.443266807988;4650.883727906804;4611.884702882429;4620.537946205378;4641.883952901179;4660.4174478190225;4677.83627573035;4268.829246830123;4301.354796780477;4318.935215971763;4345.565443455661;4380.671449641273;4309.719868208556;4325.653947684194;4372.71577347473;4404.537523560028;4410.669199810011;4183.142455796555;4315.913681726379;4344.522102568715;4351.5648435156545;4353.28170851809;4201.390798334255;4224.788760561991;4273.52991170974;4274.166537525184;4338.392625032498;4229.6827737919475;4266.552012038754;4268.509121451011;4307.117041006586;4311.051568654891;4344.283193273106;4515.029268707211;4550.476695180064;4558.042811009659;4592.1045396147765;4944.554990050877;4988.326575912241;4995.375578052744;5030.320906677588;5037.622178336603;5046.697198168122;5051.318072060299;5056.367954005749;5103.055934652101;5126.359205099363;4531.501534831166;4650.348951146842;4724.574788269072;4727.220008698595;4735.076660051292;5112.079825631347;5136.383633963948;5146.150885103991;5147.6396652234735;5188.377394712658;4891.144049791273;4912.336834527293;4913.238448040559;4917.901641967141;4971.801127954914;4845.854624361275;4963.90072198554;4990.900181996412;5009.524095210949;5031.169856973632;4908.607311415079;4927.704337739747;4928;4935.851924442272;4973.975130124326;4913.828016019422;4917.508249175054;4929.704217746875;4932.975335123301;4969.627277954168;4086.693497987603;4167.791610419466;4192.874213773592;4250.659947204216;4257.893552661147;3653.908652283714;3665.803108808269;3674.853005879735;3711.350513660099;3717.386631205875;4284.657227421799;4286.54991225923;4287.97856010718;4320.848770293088;4334.761588112684;4903.239997800275;4934.629902757308;4964.776585053609;5030.446650868402;5035.395752509722;4303.913921721548;4314.741115533078;4325.41606883073;4326.82692692295;4371.78141092944;4502.077074199781;4513.909721805611;4521.8191272349395;4522.886927826765;4570.840020599263;4558.635309175258;4705.3882995209715;4770.189067858541;4781.928271076006;4786.760661966958;4925.990172014656;4942.1104201244125;4947.703137811743;4949.950500495093;4980.128477516348;4659.301104834302;4660.650451216105;4669.299605059268;4711.575958163782;4713.858584242478;4860.975695121501;4873.658843880894;4875.488073752205;4932.8766780830765;4959.057779021974;5057.974710126573;5069.366329208849;5071.315372424676;5099.898002040012;5142.51146141116;4876.975615121902;4913.312136300992;4928.704277743347;4933.186024305949;4969.254611808257;4716.457607375196;4877.87805304856;4907.901841963212;4950.6782059166035;4981.42713587942;4762.142814293322;4772.093302272557;4772.952270477251;4801.783919723691;4814.951850481591;4844.442889067803;4861.635377346784;4868;4873.390826146731;4894.363732714724;4684.227102528181;4778.163821331323;4804.711717296974;4860.416749990024;4861 05:06:20 INFO - PROCESS | 24094 | |1;ext.html;570.4153242926001;595.1845971019703;601.5217901768094;616.6269407008763;617.4473845907911;33183.50224746628;34160.31679366414;34217.144571385725;34220.14449638754;34289.48565771515;36499.817500912526;37391.252174956484;37445.62554374456;37450;37482;7375.926240737577;7562.962185189066;7580.583067931261;7584.2415758423995;7755;7411.258874112599;9708.90291097087;10136.239782016379;10142.49287535624;10145.847812282822;9739.90260097397;9848.21214302854;9853.113219810215;9860.60557577696;9860.704178874645;7472.140703819076;9718.902810971871;9903.702888913343;10047.296689231756;10048.899511004905;9568.617255309779;9699.709008729678;9703;9707.126358627687;9712.465814380206;37361.439578406345;38066.80966595149;38093;38121;38157.80921095377;2829.1512546236254;2830.3348713052414;2838.2194896403653;2841.1902607756692;3081.691830816923;28708.712912871022;28737;28799;29120;29400;3315.1380641033506;3324.1191084362663;3354.496825476198;3378.679025492574;3440.638732933031;245917;246753;247125.76437117878;247786;247851;32645.673543264264;33706;50835;51505;51686.483135168164;31737;31813.363732725215;31860;31888.202794930312;31889.840550797562;11494.367809770543;11595.536178552931;11599.188056836108;11599.942000289944;11606.70983225426;9427.811443771086;9751.073648003428;9770.560324785401;10139.2902496826;10507.527161277761;7868.134505204423;7908.644111015018;7953.602319883983;8010.078840933251;8022;3117.828519431453;3157.1002264354547;3184.4745616973405;3204.9679503205134;3213.2288250819634;897.717219075989;904.7285814255829;917.5274733512247;970.737900766789;1051.9789604207872;24450.877745611157;24870.528364017147;25047.87476062608;25133;25227.873860630578;750.9249075092447;761.744815486807;815.5066184958133;860.0840105287848;985.7092157813319;13197.340132993311;13617.931910340385;13683.726325473435;13795.448182072805;13916.30418479072;341486;347635;349149;350605;350890;48924.266136007274;49863;49905;49986;49988.250176246656;1103.663382668294;1184.6248272214327;1214.3988725580894;1220.1580909172642;1222.254424800853;25067.623985639864;27036.459270814867;27959.476429915107;28239;28468.288292792848;40115;40521.594784051784;40888.59111408848;41076;41105.588944110175;222995;223075;223544;224735;555461;24641.137560185307;25350.366240844127;25396.984120634967;25435.61846572266;25460.3450775699;35849.46225806563;36160.45759313665;36523.26953460969;36983;37214.62785372112;32933.83533082319;33458.33083338368;33686.326273474886;33990.15024624404;34190;33505.49741753827;33548.66451335455;33681.3263734719;34017.82991085128;34038.3192336147;34204.48693269653;34483.82758086194;34570.308593828486;34621.65378346184;35650.8217458911;27851;28668.569971450863;31240.531392028683;31487;31767.523487148173;23485.17801876926;23988;24322.63516047296;24369.51260974806;24528.877355613822 05:06:20 INFO - PROCESS | 24094 | |2;jquery.html;379.84995926608974;380.5547509413986;386.61145548723533;388.4290093562464;394.8894309593315;15768.369265229392;16625.667486650276;17046.914765426154;17350.132493375342;17350.652986940284;15266.923665381686;15355.155466449369;16227.91886040571;16228.43200487983;16238.431654892052;4956.553910148095;5144.871378215537;5178.482151784829;5183.766730497136;5186.611004174683;3666.4683620874957;5370.597205209606;5931.911021334683;5934.584579079445;5939.316978547479;5727.42725727426;5851.356350801409;5875.206847075654;5896.646201227919;5906.143609176688;5911.113333000041;5946.197263369433;5966.880662386728;5974.790882319098;5979.0134627786365;3365.1755319946524;3554.91112722184;3560.3235385276716;3561.661642143992;4935.605151587864;18556.350527731465;18575.62848743031;19051.71422428651;19862;19889.801101988938;1829.2622307057657;1879.4173806120145;1909.484439201408;1969.4485544047689;2253.6394176931776;12259.938700306442;13066.54267100647;13238.801417978739;13318.267495287755;13548.729025419436;1804.7834259888766;1813.2710271042129;1835.7246413038017;1838.9816101839078;1842.81571842816;69284;70136.6493167536;70658;71169.6441517789;72072;9510.239180865514;9636.807263854824;9703.66037188695;9828.950855245677;9905.207583393456;13645.044846860625;13796.241206733524;13821.447142114404;13829.861701383059;13871.791923121162;7118.537295075804;7182;7258.927410725825;7346.52247603904;7390;6826.146731658543;6855.520113592001;6924.584524928419;6985.860282794316;7042.295770422917;6116.113163591343;6142.477889379364;6161.907571386433;6258.687065646699;6267.122602835607;1666.516710154066;1701.3109690575336;1801.6486785076784;1811.5199472139893;1832.4227868221467;848.7962888906618;932.8041111366554;941.0448394879203;1011.8785745710414;1021.9693409197736;16406;16458.259378328003;16524.421645242357;16780;16905;847.2925107535154;894.2309613732185;895.4285229422322;899.4378513429107;930.2743859789375;9385.343025988252;9638.084381983841;9770.120689138012;9777.608895644094;9843.852342214872;396166;409193.31050171354;418757;418947;420087;76327;77497.22502775013;78492.60753696309;78935;80220.59889700514;941.0683423410774;944.3531181140941;957.6025949231131;960.9183219426427;964.7925695975399;15467;15514;15602.375904964128;15639.983401078893;15990.920045399698;33255;33487.49768753422;33579.49630755492;34277.48583771195;34343.31313373768;47177.7641111806;47262;47462;47744;47832.282515761595;7427.331540161412;7680.615969201406;7757.2242775724235;7757.650905709143;7915.683372665259;11832.940835296113;12045.277283363026;12072.094592905392;12176.269423834598;12368.567100151451;10501.42242176657;10613.840792387966;10711;10745.355278683304;10770.892291077302;10285.125764310118;10537.683869483928;10567.418791966209;10686;10987.780244395228;10436.582536698446;10606.363618182933;10661.57353705874;11046.502907369348;11125.165612578927;7557;7663.348615367533;7670.7698769037015;7750.0699916010435;7829.491083079582;9227.953860230924;9793.167580755431;10463.68608941733;10502.267125924136;10755.677329680122 05:06:20 INFO - PROCESS | 24094 | |3;mootools.html;1210.6368089573125;1453.8255409350877;1466.7286551987881;1592.800899887514;1768.4959786460854;7610.315071643551;7927.6828926843;7934.761957141281;7945.4040946929;7952.165022672622;7719.807004824882;7850.097238817538;7851.332636725885;7858.685652573905;7870.645820938057;1942.7765806932243;2011.1151093518804;2017.1326329678232;2278.9544209115847;2309.4226443389152;2268.2514770125817;2347.1432926981615;2350.4241460842118;2351.988240058797;2352.0826877517784;2247.3033359658557;2260.728712554496;2272.8977196026217;2274.647429648399;2291.8166546676225;1988.204718112752;2161.9243326483656;2261.7172853393326;2274.4200228941595;2277.4420267034684;2285.6685780561893;2308.4690521180055;2318.1654604342425;2319.1998760427628;2319.7680231976838;7563.924360756377;7613.276738709814;7620.733274335427;7655.425843061793;7720.266574675396;4519.841805536823;4681.204195286809;4685.484596694361;4696.741679207642;4714.222153344694;2794.2455537004894;2840.8863645454157;2924.356641538858;2958.363951750384;2972.7770417218794;889.6930558957149;924.8762753254828;929.5538141691958;933.8179055084262;942.0814705661925;10902.61840835575;10915.672529824118;10923.672289831318;10942.45287735618;10947;4322.113966636832;4472.172648060119;4614.400127983341;4639.953600463952;4648.349231107648;9076.455412675261;9133.588988495534;9162.587683554257;9164.129407706258;9184.724458266262;4828.324034635154;4857.222844344888;4884.169691152441;4891.755412229374;4897.2898929655;4303.806328715153;4448.466184057934;4461.709988850715;4464.843730469418;4464.888377790517;3752.3433399155037;3774.6036666149657;3831.9425208621337;3859.4982652255026;3890.4164375343357;1247.5882958623633;1248.9375531223584;1250.5560526013317;1270.6442196185083;1284.0305569295122;637.4995628431659;687.3916583823352;747.5290566942791;778.7430148051129;792.9968589733991;5076.670016448919;5091.541761241506;5146.30524879144;5266.631335806457;5345.01117293302;406.3599830267282;412.3402555910519;414.7262806547664;416.35880743654434;417.1469345189096;3572.071261471984;3676.6507181817683;3689.409694448929;3695.667389934919;3759.1166075972124;9637.277204209713;9945.602175913027;10067.194624430029;10092.34399764013;10101;9867.753306167404;9936.552855121538;9948.552315145836;9952.502374881227;9955.402675839472;7343.3390994810725;7591.3926885849;7638.618069096523;7651.885221721679;7691.1924247954275;5058.342415485963;5270.341207349082;5273;5336.919946200733;5447.673139611636;9131.452112873249;9221.262299016196;9235.538223088954;9242.029586893279;9245.075492450702;8075.596220189084;8790.692325768823;9018.639254429749;9480;9500.667476638284;6712.093867327848;6774.085498457645;6805.693743781443;6823.215330236888;6832.59004459734;7160.534565253241;7377.372923301579;7379;7385.519941203805;7390.630468476447;6642.070110184482;6748.122744043243;6788.86422271542;6824.965875170592;6896.620685862325;6311.873762524816;6385.106085148176;6393.6163830170335;6464.482841372773;6498.772542960974;6065.939340606537;6073.392660733891;6123.295820980644;6139.570230083851;6142.802153580009;4325.545817689097;4328.956710432855;4363.323684828857;4412.867613971586;4495.7976891039325;4382.430284063052;4401.757903315349;4452.109578084332;4465.888352791077;4471.262241730208 05:06:20 INFO - PROCESS | 24094 | |4;prototype.html;317.2607823770614;319.35649665923165;321.11052384893844;331.19189178404673;331.3703962471306;5129.640645229013;5145.4340022597535;5211.140161873291;5220.6606570572885;5225.190095535198;5136.537711605954;5159.355080614923;5163.096458119823;5171.870703232421;5204.479552044793;3834.6357096075826;3886.1061955750192;4051.6556092732153;4082.265192265391;4099.672026237894;4057.16828050249;4089.3048181809013;4092.6930480214105;4101.384792281152;4101.979490102545;3836.827342769582;4050.473438452997;4056.8377264909514;4064.6748260139266;4067.8169482373214;3912.2762288976487;4048.736832105904;4056.290149223874;4060.573639767826;4061.289274376972;3572.7677700949357;3582.8208589570418;3594.1733401317583;3598.676119149289;3620.25784714133;4904.411470623548;4908.975455122737;4916.803327866881;4928.747026962224;4937.21004639256;4562.954370456286;4643.767811609406;4681.133990211822;4683.531646835323;4692.882677933045;5427.375851777057;5429.348478182604;5442.210879422501;5453.618246722692;5464.289642346509;3930.587288334741;3941;3947.131631041166;3955.3869150281753;3957.3181397905773;5556.666600003972;5700.543956483471;5717.771289148471;5720.713964301768;5773.797917072924;4024.0945787197647;4045.2314060328445;4047.696422768245;4047.846363786307;4048.3927410888014;4120.75275483472;4124.938125928114;4130.194612050681;4137.77242251679;4138.482689663792;4517.93828450314;4612.5156858530045;4654.976725116353;4656.16189085961;4659.068186362741;5438.211459338374;5447.727613619303;5456.972715136399;5467.152591348347;5474.439784661352;1414.6463384153963;1426.2227086238024;1429.3491017874371;1429.892758043151;1434.7274017936559;904.6291020681489;948.3266880514911;977.8705595037743;980.9166220871306;999.695092996643;4675.859724208279;4680.368150299734;4686.250199967989;4688.2733176357715;4717;5530.198121272393;5544.584156188302;5549.1676248562235;5553.972230138824;5557.166425036277;4562.9771851141195;4740.288956656529;4749.912556838083;4753.786079626425;4790.329353890388;3013.352129292213;3038.0885734279627;3046.1166261783833;3048.131282584453;3051.61854768154;5316.783346075646;5321.228421878884;5332.653377530448;5339.199120131933;5347.839564813062;5559.916601250984;5820.738066787005;5842.678652674143;5859.238299021185;5879.206307148565;5318.670332416896;5327.174287985368;5327.467253274642;5330.253764473055;5358.517733404013;5428.45715428454;5664.660120392789;5675.801346952837;5679.488846003879;5682.289713785777;5585.664860108406;5596.356419011866;5599.916001259903;5621.662700237999;5623.409541998031;5311.176767601028;5315.787368505216;5316.920246196388;5377.8117765878005;5378.97310513445;3849.730518863653;4041.9797901011484;4055.8986025349604;4066.573009834043;4073.511178658461;5569.777208911761;5579.46995035471;5579.609427340048;5592.748326325243;5596.86007849807;5386.919196212139;5392.595555333287;5394.811181608625;5395.109806881821;5405.135228346215;5329.726276279323;5331.466853314638;5416.377116631637;5429.782808687608;5439.129739241703;5086.720230387365;5306.124489459196;5309.761060752353;5331.306930099062;5332.866678333073;5319;5391.353037635509;5402.108652072364;5417.377001644862;5420.7289635518855;5346.652467589594;5368.1679339702405;5368.516833485005;5374.731263436891;5378.112611419228 05:06:20 INFO - PROCESS | 24094 | |5;yui.html;631.1479502671393;639.7281155508913;642.8585711143548;653.8332725155085;668.5854770042574;11634.709132271697;11768.705782355435;11909.285442873434;11976.76046479071;12180.147389682726;12616.747665046694;12663.683407914807;12722.236665800036;12723.427445764939;12740.745185096292;620.4663988969482;748.4199745197461;776.3323541754102;781.4803155901348;789.3369569561568;786.7167819584945;787.6534324897056;788.4796034617153;789.5065584009993;790.3124281874777;816.6529225079347;818.2880893622556;818.3207937411963;818.5988865455913;819.6147810529042;643.0771842406139;658.4403257231363;658.6739563915844;790.9881351779728;811.7077851973285;595.2113449679149;596.2427716799683;596.3827438601071;597.6862147372664;599.307799491588;12533.874661253452;12601.30692811895;12612.243265404106;12625.810612840814;12641.178323408949;11348.829767553494;11618.767624647544;11635.534578616845;11872.40637968098;11984;9314.534273286308;9504.42973421597;9700.854487182698;9712;9714.90285097147;3247.0908145719236;3318.5685860837934;3359.10983589349;3363.3105213431186;3401.557797486336;46506.767466162455;46585;47232.7638361806;47421.288680669815;48822.755886220344;8775;8785.780355491164;8894.110588941054;8999.100089990949;9052.547372631341;16149.677006459806;16314.75527867083;16341.509754707378;16966.915165424092;17518;6486.318936511599;6521.184851893513;6578.046183303394;6692.5984440932725;6698.4641228701585;3683.4658974448553;3696.611855755161;3702.555693316819;3710.9443358349645;3810.5427348717776;2880.1791489425414;2939.559066140096;2950.79344445891;2953.926151846221;2954.1875984104113;483.3764443867442;493.5188191513246;495.8115915951987;501.90714717777325;503.6902305082421;481.32614339923686;535.922291267764;561.0210183230289;584.5352944409204;596.4810614765096;6921.273266307066;7032.718691252395;7050.964745176344;7166.670831979627;7370.668319925616;453.75497231495285;534.5937087813212;534.9251104845247;540.2922171954751;554.0940562180783;3481.9477707834403;3517.824108794601;3612.747107702488;3696.482492451059;3756.549214094326;56111.43888561144;56540.71729641408;56736.716316418155;57130.14304785432;57329.713351432976;48049;49222.50777492251;49259.26111108336;49837;49974.500254997714;41755.7912210437;44517;44876.3268550972;45442.54557454383;45450.72746362669;7103;7280.490365674564;7342.9632851835395;7550.395968322411;7572.39420846342;30324;30670.693293066783;30731.078067658007;30814.229644259074;31328.53007204848;38367.42448863213;40387.596124038384;40753.1849363017;40895.795521022206;41018.79490602528;9125.087491250822;9170.770730731518;9401.717948461557;9510.762230944005;9534.713958581253;9994.050565196294;10031.398116113056;10211.948940255548;10370.11853992389;10718.196135289729;9869.407835529892;9986.151177149733;10339.741506462398;10494.47527623631;10626.787464250827;9741.951290243504;9787.559559819683;10469.790604188025;10538.683839484827;10627.521761520904;9481.194098501428;9530.1899338557;9636.662716804878;9649.565769540528;10090.8486372703;8885.454318833354;8891.777705557413;9088.909110909071;9107.316951228551;9316.463770138267;8143.389245806707;8212.219839115274;8741.606627701642;8787.560621969003;8792.60433280491 05:06:20 INFO - PROCESS | 24094 | __end_tp_report 05:06:20 INFO - PROCESS | 24094 | __start_cc_report 05:06:20 INFO - PROCESS | 24094 | _x_x_mozilla_cycle_collect,973 05:06:20 INFO - PROCESS | 24094 | __end_cc_report 05:06:20 INFO - PROCESS | 24094 | __startTimestamp1461585980659__endTimestamp 05:06:20 INFO - PROCESS | 24094 | 05:06:20 INFO - PROCESS | 24094 | ------- Summary: start ------- 05:06:20 INFO - PROCESS | 24094 | Number of tests: 6 05:06:20 INFO - PROCESS | 24094 | 05:06:20 INFO - PROCESS | 24094 | [#0] dojo.html Cycles:165 Average:4612.74 Median:4727.22 stddev:481.14 (10.2%) stddev-sans-first:455.33 05:06:20 INFO - PROCESS | 24094 | Values: 2576.6 2637.6 2659.5 2672.6 2686.8 4581.3 4606.0 4617.9 4639.4 4650.9 4611.9 4620.5 4641.9 4660.4 4677.8 4268.8 4301.4 4318.9 4345.6 4380.7 4309.7 4325.7 4372.7 4404.5 4410.7 4183.1 4315.9 4344.5 4351.6 4353.3 4201.4 4224.8 4273.5 4274.2 4338.4 4229.7 4266.6 4268.5 4307.1 4311.1 4344.3 4515.0 4550.5 4558.0 4592.1 4944.6 4988.3 4995.4 5030.3 5037.6 5046.7 5051.3 5056.4 5103.1 5126.4 4531.5 4650.3 4724.6 4727.2 4735.1 5112.1 5136.4 5146.2 5147.6 5188.4 4891.1 4912.3 4913.2 4917.9 4971.8 4845.9 4963.9 4990.9 5009.5 5031.2 4908.6 4927.7 4928.0 4935.9 4974.0 4913.8 4917.5 4929.7 4933.0 4969.6 4086.7 4167.8 4192.9 4250.7 4257.9 3653.9 3665.8 3674.9 3711.4 3717.4 4284.7 4286.5 4288.0 4320.8 4334.8 4903.2 4934.6 4964.8 5030.4 5035.4 4303.9 4314.7 4325.4 4326.8 4371.8 4502.1 4513.9 4521.8 4522.9 4570.8 4558.6 4705.4 4770.2 4781.9 4786.8 4926.0 4942.1 4947.7 4950.0 4980.1 4659.3 4660.7 4669.3 4711.6 4713.9 4861.0 4873.7 4875.5 4932.9 4959.1 5058.0 5069.4 5071.3 5099.9 5142.5 4877.0 4913.3 4928.7 4933.2 4969.3 4716.5 4877.9 4907.9 4950.7 4981.4 4762.1 4772.1 4773.0 4801.8 4815.0 4844.4 4861.6 4868.0 4873.4 4894.4 4684.2 4778.2 4804.7 4860.4 4861.0 05:06:20 INFO - PROCESS | 24094 | 05:06:20 INFO - PROCESS | 24094 | [#1] ext.html Cycles:180 Average:43395.81 Median:34003.99 stddev:81415.56 (239.4%) stddev-sans-first:81580.46 05:06:20 INFO - PROCESS | 24094 | Values: 570.4 595.2 601.5 616.6 617.4 33183.5 34160.3 34217.1 34220.1 34289.5 36499.8 37391.3 37445.6 37450.0 37482.0 7375.9 7563.0 7580.6 7584.2 7755.0 7411.3 9708.9 10136.2 10142.5 10145.8 9739.9 9848.2 9853.1 9860.6 9860.7 7472.1 9718.9 9903.7 10047.3 10048.9 9568.6 9699.7 9703.0 9707.1 9712.5 37361.4 38066.8 38093.0 38121.0 38157.8 2829.2 2830.3 2838.2 2841.2 3081.7 28708.7 28737.0 28799.0 29120.0 29400.0 3315.1 3324.1 3354.5 3378.7 3440.6 245917.0 246753.0 247125.8 247786.0 247851.0 32645.7 33706.0 50835.0 51505.0 51686.5 31737.0 31813.4 31860.0 31888.2 31889.8 11494.4 11595.5 11599.2 11599.9 11606.7 9427.8 9751.1 9770.6 10139.3 10507.5 7868.1 7908.6 7953.6 8010.1 8022.0 3117.8 3157.1 3184.5 3205.0 3213.2 897.7 904.7 917.5 970.7 1052.0 24450.9 24870.5 25047.9 25133.0 25227.9 750.9 761.7 815.5 860.1 985.7 13197.3 13617.9 13683.7 13795.4 13916.3 341486.0 347635.0 349149.0 350605.0 350890.0 48924.3 49863.0 49905.0 49986.0 49988.3 1103.7 1184.6 1214.4 1220.2 1222.3 25067.6 27036.5 27959.5 28239.0 28468.3 40115.0 40521.6 40888.6 41076.0 41105.6 222995.0 223075.0 223544.0 224735.0 555461.0 24641.1 25350.4 25397.0 25435.6 25460.3 35849.5 36160.5 36523.3 36983.0 37214.6 32933.8 33458.3 33686.3 33990.2 34190.0 33505.5 33548.7 33681.3 34017.8 34038.3 34204.5 34483.8 34570.3 34621.7 35650.8 27851.0 28668.6 31240.5 31487.0 31767.5 23485.2 23988.0 24322.6 24369.5 24528.9 05:06:20 INFO - PROCESS | 24094 | 05:06:20 INFO - PROCESS | 24094 | [#2] jquery.html Cycles:180 Average:24950.37 Median:402679.66 stddev:67979.21 (16.9%) stddev-sans-first:68144.87 05:06:20 INFO - PROCESS | 24094 | Values: 379.8 380.6 386.6 388.4 394.9 15768.4 16625.7 17046.9 17350.1 17350.7 15266.9 15355.2 16227.9 16228.4 16238.4 4956.6 5144.9 5178.5 5183.8 5186.6 3666.5 5370.6 5931.9 5934.6 5939.3 5727.4 5851.4 5875.2 5896.6 5906.1 5911.1 5946.2 5966.9 5974.8 5979.0 3365.2 3554.9 3560.3 3561.7 4935.6 18556.4 18575.6 19051.7 19862.0 19889.8 1829.3 1879.4 1909.5 1969.4 2253.6 12259.9 13066.5 13238.8 13318.3 13548.7 1804.8 1813.3 1835.7 1839.0 1842.8 69284.0 70136.6 70658.0 71169.6 72072.0 9510.2 9636.8 9703.7 9829.0 9905.2 13645.0 13796.2 13821.4 13829.9 13871.8 7118.5 7182.0 7258.9 7346.5 7390.0 6826.1 6855.5 6924.6 6985.9 7042.3 6116.1 6142.5 6161.9 6258.7 6267.1 1666.5 1701.3 1801.6 1811.5 1832.4 848.8 932.8 941.0 1011.9 1022.0 16406.0 16458.3 16524.4 16780.0 16905.0 847.3 894.2 895.4 899.4 930.3 9385.3 9638.1 9770.1 9777.6 9843.9 396166.0 409193.3 418757.0 418947.0 420087.0 76327.0 77497.2 78492.6 78935.0 80220.6 941.1 944.4 957.6 960.9 964.8 15467.0 15514.0 15602.4 15640.0 15990.9 33255.0 33487.5 33579.5 34277.5 34343.3 47177.8 47262.0 47462.0 47744.0 47832.3 7427.3 7680.6 7757.2 7757.7 7915.7 11832.9 12045.3 12072.1 12176.3 12368.6 10501.4 10613.8 10711.0 10745.4 10770.9 10285.1 10537.7 10567.4 10686.0 10987.8 10436.6 10606.4 10661.6 11046.5 11125.2 7557.0 7663.3 7670.8 7750.1 7829.5 9228.0 9793.2 10463.7 10502.3 10755.7 05:06:20 INFO - PROCESS | 24094 | 05:06:20 INFO - PROCESS | 24094 | [#3] mootools.html Cycles:180 Average:5187.04 Median:4887.96 stddev:2934.36 (60.0%) stddev-sans-first:2927.37 05:06:20 INFO - PROCESS | 24094 | Values: 1210.6 1453.8 1466.7 1592.8 1768.5 7610.3 7927.7 7934.8 7945.4 7952.2 7719.8 7850.1 7851.3 7858.7 7870.6 1942.8 2011.1 2017.1 2279.0 2309.4 2268.3 2347.1 2350.4 2352.0 2352.1 2247.3 2260.7 2272.9 2274.6 2291.8 1988.2 2161.9 2261.7 2274.4 2277.4 2285.7 2308.5 2318.2 2319.2 2319.8 7563.9 7613.3 7620.7 7655.4 7720.3 4519.8 4681.2 4685.5 4696.7 4714.2 2794.2 2840.9 2924.4 2958.4 2972.8 889.7 924.9 929.6 933.8 942.1 10902.6 10915.7 10923.7 10942.5 10947.0 4322.1 4472.2 4614.4 4640.0 4648.3 9076.5 9133.6 9162.6 9164.1 9184.7 4828.3 4857.2 4884.2 4891.8 4897.3 4303.8 4448.5 4461.7 4464.8 4464.9 3752.3 3774.6 3831.9 3859.5 3890.4 1247.6 1248.9 1250.6 1270.6 1284.0 637.5 687.4 747.5 778.7 793.0 5076.7 5091.5 5146.3 5266.6 5345.0 406.4 412.3 414.7 416.4 417.1 3572.1 3676.7 3689.4 3695.7 3759.1 9637.3 9945.6 10067.2 10092.3 10101.0 9867.8 9936.6 9948.6 9952.5 9955.4 7343.3 7591.4 7638.6 7651.9 7691.2 5058.3 5270.3 5273.0 5336.9 5447.7 9131.5 9221.3 9235.5 9242.0 9245.1 8075.6 8790.7 9018.6 9480.0 9500.7 6712.1 6774.1 6805.7 6823.2 6832.6 7160.5 7377.4 7379.0 7385.5 7390.6 6642.1 6748.1 6788.9 6825.0 6896.6 6311.9 6385.1 6393.6 6464.5 6498.8 6065.9 6073.4 6123.3 6139.6 6142.8 4325.5 4329.0 4363.3 4412.9 4495.8 4382.4 4401.8 4452.1 4465.9 4471.3 05:06:20 INFO - PROCESS | 24094 | 05:06:20 INFO - PROCESS | 24094 | [#4] prototype.html Cycles:180 Average:4531.35 Median:5167.48 stddev:1304.04 (25.2%) stddev-sans-first:1268.76 05:06:20 INFO - PROCESS | 24094 | Values: 317.3 319.4 321.1 331.2 331.4 5129.6 5145.4 5211.1 5220.7 5225.2 5136.5 5159.4 5163.1 5171.9 5204.5 3834.6 3886.1 4051.7 4082.3 4099.7 4057.2 4089.3 4092.7 4101.4 4102.0 3836.8 4050.5 4056.8 4064.7 4067.8 3912.3 4048.7 4056.3 4060.6 4061.3 3572.8 3582.8 3594.2 3598.7 3620.3 4904.4 4909.0 4916.8 4928.7 4937.2 4563.0 4643.8 4681.1 4683.5 4692.9 5427.4 5429.3 5442.2 5453.6 5464.3 3930.6 3941.0 3947.1 3955.4 3957.3 5556.7 5700.5 5717.8 5720.7 5773.8 4024.1 4045.2 4047.7 4047.8 4048.4 4120.8 4124.9 4130.2 4137.8 4138.5 4517.9 4612.5 4655.0 4656.2 4659.1 5438.2 5447.7 5457.0 5467.2 5474.4 1414.6 1426.2 1429.3 1429.9 1434.7 904.6 948.3 977.9 980.9 999.7 4675.9 4680.4 4686.3 4688.3 4717.0 5530.2 5544.6 5549.2 5554.0 5557.2 4563.0 4740.3 4749.9 4753.8 4790.3 3013.4 3038.1 3046.1 3048.1 3051.6 5316.8 5321.2 5332.7 5339.2 5347.8 5559.9 5820.7 5842.7 5859.2 5879.2 5318.7 5327.2 5327.5 5330.3 5358.5 5428.5 5664.7 5675.8 5679.5 5682.3 5585.7 5596.4 5599.9 5621.7 5623.4 5311.2 5315.8 5316.9 5377.8 5379.0 3849.7 4042.0 4055.9 4066.6 4073.5 5569.8 5579.5 5579.6 5592.7 5596.9 5386.9 5392.6 5394.8 5395.1 5405.1 5329.7 5331.5 5416.4 5429.8 5439.1 5086.7 5306.1 5309.8 5331.3 5332.9 5319.0 5391.4 5402.1 5417.4 5420.7 5346.7 5368.2 5368.5 5374.7 5378.1 05:06:20 INFO - PROCESS | 24094 | 05:06:20 INFO - PROCESS | 24094 | [#5] yui.html Cycles:180 Average:12799.72 Median:538.11 stddev:15349.90 (2852.6%) stddev-sans-first:15365.76 05:06:20 INFO - PROCESS | 24094 | Values: 631.1 639.7 642.9 653.8 668.6 11634.7 11768.7 11909.3 11976.8 12180.1 12616.7 12663.7 12722.2 12723.4 12740.7 620.5 748.4 776.3 781.5 789.3 786.7 787.7 788.5 789.5 790.3 816.7 818.3 818.3 818.6 819.6 643.1 658.4 658.7 791.0 811.7 595.2 596.2 596.4 597.7 599.3 12533.9 12601.3 12612.2 12625.8 12641.2 11348.8 11618.8 11635.5 11872.4 11984.0 9314.5 9504.4 9700.9 9712.0 9714.9 3247.1 3318.6 3359.1 3363.3 3401.6 46506.8 46585.0 47232.8 47421.3 48822.8 8775.0 8785.8 8894.1 8999.1 9052.5 16149.7 16314.8 16341.5 16966.9 17518.0 6486.3 6521.2 6578.0 6692.6 6698.5 3683.5 3696.6 3702.6 3710.9 3810.5 2880.2 2939.6 2950.8 2953.9 2954.2 483.4 493.5 495.8 501.9 503.7 481.3 535.9 561.0 584.5 596.5 6921.3 7032.7 7051.0 7166.7 7370.7 453.8 534.6 534.9 540.3 554.1 3481.9 3517.8 3612.7 3696.5 3756.5 56111.4 56540.7 56736.7 57130.1 57329.7 48049.0 49222.5 49259.3 49837.0 49974.5 41755.8 44517.0 44876.3 45442.5 45450.7 7103.0 7280.5 7343.0 7550.4 7572.4 30324.0 30670.7 30731.1 30814.2 31328.5 38367.4 40387.6 40753.2 40895.8 41018.8 9125.1 9170.8 9401.7 9510.8 9534.7 9994.1 10031.4 10211.9 10370.1 10718.2 9869.4 9986.2 10339.7 10494.5 10626.8 9742.0 9787.6 10469.8 10538.7 10627.5 9481.2 9530.2 9636.7 9649.6 10090.8 8885.5 8891.8 9088.9 9107.3 9316.5 8143.4 8212.2 8741.6 8787.6 8792.6 05:06:20 INFO - PROCESS | 24094 | -------- Summary: end -------- 05:06:20 INFO - PROCESS | 24094 | 05:06:21 INFO - TEST-INFO | 24094: exit 0 05:06:21 INFO - TEST-OK | dromaeo_css | took 1118481ms 05:06:21 INFO - TEST-START | kraken 05:06:21 INFO - operating with platform_type : linux_ 05:06:21 INFO - Initialising browser for kraken test... 05:06:21 INFO - TEST-INFO | started process 24271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7GhWMc/profile http://localhost:53084/getInfo.html) 05:06:25 INFO - PROCESS | 24271 | __metrics Screen width/height:1600/1200 05:06:25 INFO - PROCESS | 24271 | colorDepth:24 05:06:25 INFO - PROCESS | 24271 | Browser inner width/height: 1024/697 05:06:25 INFO - PROCESS | 24271 | __metrics 05:06:26 ERROR - PROCESS | 24271 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:06:27 INFO - TEST-INFO | 24271: exit 0 05:06:27 INFO - Browser initialized. 05:06:27 INFO - Running cycle 1/1 for kraken test... 05:06:27 INFO - TEST-INFO | started process 24354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7GhWMc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:39 INFO - PROCESS | 24354 | RSS: Main: 155246592 05:06:39 INFO - PROCESS | 24354 | 05:06:42 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53084/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:43 INFO - PROCESS | 24354 | RSS: Main: 210288640 05:06:43 INFO - PROCESS | 24354 | 05:06:46 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53084/tests/kraken/driver.html?testName=audio-dft) 05:06:46 INFO - PROCESS | 24354 | RSS: Main: 195715072 05:06:46 INFO - PROCESS | 24354 | 05:06:49 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53084/tests/kraken/driver.html?testName=audio-fft) 05:06:50 INFO - PROCESS | 24354 | RSS: Main: 266346496 05:06:50 INFO - PROCESS | 24354 | 05:06:52 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53084/tests/kraken/driver.html?testName=audio-oscillator) 05:06:53 INFO - PROCESS | 24354 | RSS: Main: 174776320 05:06:53 INFO - PROCESS | 24354 | 05:06:55 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53084/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:56 INFO - PROCESS | 24354 | RSS: Main: 178839552 05:06:56 INFO - PROCESS | 24354 | 05:06:59 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53084/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:59 INFO - PROCESS | 24354 | RSS: Main: 214794240 05:06:59 INFO - PROCESS | 24354 | 05:07:03 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53084/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:03 INFO - PROCESS | 24354 | RSS: Main: 215543808 05:07:03 INFO - PROCESS | 24354 | 05:07:06 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53084/tests/kraken/driver.html?testName=json-parse-financial) 05:07:07 INFO - PROCESS | 24354 | RSS: Main: 216211456 05:07:07 INFO - PROCESS | 24354 | 05:07:09 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53084/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:09 INFO - PROCESS | 24354 | RSS: Main: 201629696 05:07:09 INFO - PROCESS | 24354 | 05:07:11 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53084/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:12 INFO - PROCESS | 24354 | RSS: Main: 204976128 05:07:12 INFO - PROCESS | 24354 | 05:07:14 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53084/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:15 INFO - PROCESS | 24354 | RSS: Main: 216768512 05:07:15 INFO - PROCESS | 24354 | 05:07:17 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:18 INFO - PROCESS | 24354 | RSS: Main: 224727040 05:07:18 INFO - PROCESS | 24354 | 05:07:21 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:21 INFO - PROCESS | 24354 | RSS: Main: 217808896 05:07:21 INFO - PROCESS | 24354 | 05:07:23 INFO - PROCESS | 24354 | Cycle 1(1): loaded http://localhost:53084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53084/tests/kraken/driver.html?testName=ai-astar) 05:07:24 INFO - PROCESS | 24354 | RSS: Main: 282116096 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | __start_tp_report 05:07:24 INFO - PROCESS | 24354 | _x_x_mozilla_page_load 05:07:24 INFO - PROCESS | 24354 | _x_x_mozilla_page_load_details 05:07:24 INFO - PROCESS | 24354 | |i|pagename|runs| 05:07:24 INFO - PROCESS | 24354 | |0;ai-astar;112;114;107;113;114;115;102;113;112;112 05:07:24 INFO - PROCESS | 24354 | |1;audio-beat-detection;158;129;157;184;133;157;164;133;190;132 05:07:24 INFO - PROCESS | 24354 | |2;audio-dft;162;161;163;162;162;163;162;161;162;163 05:07:24 INFO - PROCESS | 24354 | |3;audio-fft;74;73;128;114;74;73;73;130;101;76 05:07:24 INFO - PROCESS | 24354 | |4;audio-oscillator;93;94;146;94;94;94;155;93;93;148 05:07:24 INFO - PROCESS | 24354 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;119;117 05:07:24 INFO - PROCESS | 24354 | |6;imaging-darkroom;147;146;146;147;145;146;146;146;148;146 05:07:24 INFO - PROCESS | 24354 | |7;imaging-desaturate;96;94;95;95;95;94;94;95;95;95 05:07:24 INFO - PROCESS | 24354 | |8;json-parse-financial;65;66;66;64;67;66;64;91;64;62 05:07:24 INFO - PROCESS | 24354 | |9;json-stringify-tinderbox;64;65;64;64;65;64;64;64;64;64 05:07:24 INFO - PROCESS | 24354 | |10;stanford-crypto-aes;79;78;79;82;80;83;80;80;80;83 05:07:24 INFO - PROCESS | 24354 | |11;stanford-crypto-ccm;136;143;132;136;135;132;133;133;171;135 05:07:24 INFO - PROCESS | 24354 | |12;stanford-crypto-pbkdf2;180;173;180;175;181;182;182;175;176;177 05:07:24 INFO - PROCESS | 24354 | |13;stanford-crypto-sha256-iterative;73;72;76;73;79;73;73;72;73;72 05:07:24 INFO - PROCESS | 24354 | __end_tp_report 05:07:24 INFO - PROCESS | 24354 | __start_cc_report 05:07:24 INFO - PROCESS | 24354 | _x_x_mozilla_cycle_collect,1882 05:07:24 INFO - PROCESS | 24354 | __end_cc_report 05:07:24 INFO - PROCESS | 24354 | __startTimestamp1461586044034__endTimestamp 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | ------- Summary: start ------- 05:07:24 INFO - PROCESS | 24354 | Number of tests: 14 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.95 (3.5%) stddev-sans-first:4.18 05:07:24 INFO - PROCESS | 24354 | Values: 112.0 114.0 107.0 113.0 114.0 115.0 102.0 113.0 112.0 112.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:157.50 stddev:21.91 (13.9%) stddev-sans-first:23.18 05:07:24 INFO - PROCESS | 24354 | Values: 158.0 129.0 157.0 184.0 133.0 157.0 164.0 133.0 190.0 132.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:07:24 INFO - PROCESS | 24354 | Values: 162.0 161.0 163.0 162.0 162.0 163.0 162.0 161.0 162.0 163.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#3] audio-fft Cycles:10 Average:91.60 Median:73.00 stddev:24.25 (33.2%) stddev-sans-first:24.87 05:07:24 INFO - PROCESS | 24354 | Values: 74.0 73.0 128.0 114.0 74.0 73.0 73.0 130.0 101.0 76.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:93.50 stddev:27.19 (29.1%) stddev-sans-first:28.10 05:07:24 INFO - PROCESS | 24354 | Values: 93.0 94.0 146.0 94.0 94.0 94.0 155.0 93.0 93.0 148.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 05:07:24 INFO - PROCESS | 24354 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 119.0 117.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 05:07:24 INFO - PROCESS | 24354 | Values: 147.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 148.0 146.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 05:07:24 INFO - PROCESS | 24354 | Values: 96.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:66.00 stddev:8.38 (12.7%) stddev-sans-first:8.84 05:07:24 INFO - PROCESS | 24354 | Values: 65.0 66.0 66.0 64.0 67.0 66.0 64.0 91.0 64.0 62.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 05:07:24 INFO - PROCESS | 24354 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:1.71 (2.1%) stddev-sans-first:1.74 05:07:24 INFO - PROCESS | 24354 | Values: 79.0 78.0 79.0 82.0 80.0 83.0 80.0 80.0 80.0 83.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:135.50 stddev:11.82 (8.7%) stddev-sans-first:12.50 05:07:24 INFO - PROCESS | 24354 | Values: 136.0 143.0 132.0 136.0 135.0 132.0 133.0 133.0 171.0 135.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:180.00 stddev:3.28 (1.8%) stddev-sans-first:3.41 05:07:24 INFO - PROCESS | 24354 | Values: 180.0 173.0 180.0 175.0 181.0 182.0 182.0 175.0 176.0 177.0 05:07:24 INFO - PROCESS | 24354 | 05:07:24 INFO - PROCESS | 24354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:73.00 stddev:2.22 (3.0%) stddev-sans-first:2.35 05:07:24 INFO - PROCESS | 24354 | Values: 73.0 72.0 76.0 73.0 79.0 73.0 73.0 72.0 73.0 72.0 05:07:24 INFO - PROCESS | 24354 | -------- Summary: end -------- 05:07:24 INFO - PROCESS | 24354 | 05:07:25 INFO - TEST-INFO | 24354: exit 0 05:07:25 INFO - TEST-OK | kraken | took 63680ms 05:07:25 INFO - SUITE-END | took 1182s 05:07:25 INFO - Completed test suite (00:19:42) 05:07:25 INFO - javascript benchmark 05:07:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.6392705021294, 2637.643918071061, 2659.534581448246, 2672.5723884178537, 2686.7716244119256, 4581.289900065487, 4605.953940460595, 4617.884552886179, 4639.443266807988, 4650.883727906804, 4611.884702882429, 4620.537946205378, 4641.883952901179, 4660.4174478190225, 4677.83627573035, 4268.829246830123, 4301.354796780477, 4318.935215971763, 4345.565443455661, 4380.671449641273, 4309.719868208556, 4325.653947684194, 4372.71577347473, 4404.537523560028, 4410.669199810011, 4183.142455796555, 4315.913681726379, 4344.522102568715, 4351.5648435156545, 4353.28170851809, 4201.390798334255, 4224.788760561991, 4273.52991170974, 4274.166537525184, 4338.392625032498, 4229.6827737919475, 4266.552012038754, 4268.509121451011, 4307.117041006586, 4311.051568654891, 4344.283193273106, 4515.029268707211, 4550.476695180064, 4558.042811009659, 4592.1045396147765, 4944.554990050877, 4988.326575912241, 4995.375578052744, 5030.320906677588, 5037.622178336603, 5046.697198168122, 5051.318072060299, 5056.367954005749, 5103.055934652101, 5126.359205099363, 4531.501534831166, 4650.348951146842, 4724.574788269072, 4727.220008698595, 4735.076660051292, 5112.079825631347, 5136.383633963948, 5146.150885103991, 5147.6396652234735, 5188.377394712658, 4891.144049791273, 4912.336834527293, 4913.238448040559, 4917.901641967141, 4971.801127954914, 4845.854624361275, 4963.90072198554, 4990.900181996412, 5009.524095210949, 5031.169856973632, 4908.607311415079, 4927.704337739747, 4928.0, 4935.851924442272, 4973.975130124326, 4913.828016019422, 4917.508249175054, 4929.704217746875, 4932.975335123301, 4969.627277954168, 4086.693497987603, 4167.791610419466, 4192.874213773592, 4250.659947204216, 4257.893552661147, 3653.908652283714, 3665.803108808269, 3674.853005879735, 3711.350513660099, 3717.386631205875, 4284.657227421799, 4286.54991225923, 4287.97856010718, 4320.848770293088, 4334.761588112684, 4903.239997800275, 4934.629902757308, 4964.776585053609, 5030.446650868402, 5035.395752509722, 4303.913921721548, 4314.741115533078, 4325.41606883073, 4326.82692692295, 4371.78141092944, 4502.077074199781, 4513.909721805611, 4521.8191272349395, 4522.886927826765, 4570.840020599263, 4558.635309175258, 4705.3882995209715, 4770.189067858541, 4781.928271076006, 4786.760661966958, 4925.990172014656, 4942.1104201244125, 4947.703137811743, 4949.950500495093, 4980.128477516348, 4659.301104834302, 4660.650451216105, 4669.299605059268, 4711.575958163782, 4713.858584242478, 4860.975695121501, 4873.658843880894, 4875.488073752205, 4932.8766780830765, 4959.057779021974, 5057.974710126573, 5069.366329208849, 5071.315372424676, 5099.898002040012, 5142.51146141116, 4876.975615121902, 4913.312136300992, 4928.704277743347, 4933.186024305949, 4969.254611808257, 4716.457607375196, 4877.87805304856, 4907.901841963212, 4950.6782059166035, 4981.42713587942, 4762.142814293322, 4772.093302272557, 4772.952270477251, 4801.783919723691, 4814.951850481591, 4844.442889067803, 4861.635377346784, 4868.0, 4873.390826146731, 4894.363732714724, 4684.227102528181, 4778.163821331323, 4804.711717296974, 4860.416749990024, 4861.0], "value": 4582.50076913315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4153242926001, 595.1845971019703, 601.5217901768094, 616.6269407008763, 617.4473845907911, 33183.50224746628, 34160.31679366414, 34217.144571385725, 34220.14449638754, 34289.48565771515, 36499.817500912526, 37391.252174956484, 37445.62554374456, 37450.0, 37482.0, 7375.926240737577, 7562.962185189066, 7580.583067931261, 7584.2415758423995, 7755.0, 7411.258874112599, 9708.90291097087, 10136.239782016379, 10142.49287535624, 10145.847812282822, 9739.90260097397, 9848.21214302854, 9853.113219810215, 9860.60557577696, 9860.704178874645, 7472.140703819076, 9718.902810971871, 9903.702888913343, 10047.296689231756, 10048.899511004905, 9568.617255309779, 9699.709008729678, 9703.0, 9707.126358627687, 9712.465814380206, 37361.439578406345, 38066.80966595149, 38093.0, 38121.0, 38157.80921095377, 2829.1512546236254, 2830.3348713052414, 2838.2194896403653, 2841.1902607756692, 3081.691830816923, 28708.712912871022, 28737.0, 28799.0, 29120.0, 29400.0, 3315.1380641033506, 3324.1191084362663, 3354.496825476198, 3378.679025492574, 3440.638732933031, 245917.0, 246753.0, 247125.76437117878, 247786.0, 247851.0, 32645.673543264264, 33706.0, 50835.0, 51505.0, 51686.483135168164, 31737.0, 31813.363732725215, 31860.0, 31888.202794930312, 31889.840550797562, 11494.367809770543, 11595.536178552931, 11599.188056836108, 11599.942000289944, 11606.70983225426, 9427.811443771086, 9751.073648003428, 9770.560324785401, 10139.2902496826, 10507.527161277761, 7868.134505204423, 7908.644111015018, 7953.602319883983, 8010.078840933251, 8022.0, 3117.828519431453, 3157.1002264354547, 3184.4745616973405, 3204.9679503205134, 3213.2288250819634, 897.717219075989, 904.7285814255829, 917.5274733512247, 970.737900766789, 1051.9789604207872, 24450.877745611157, 24870.528364017147, 25047.87476062608, 25133.0, 25227.873860630578, 750.9249075092447, 761.744815486807, 815.5066184958133, 860.0840105287848, 985.7092157813319, 13197.340132993311, 13617.931910340385, 13683.726325473435, 13795.448182072805, 13916.30418479072, 341486.0, 347635.0, 349149.0, 350605.0, 350890.0, 48924.266136007274, 49863.0, 49905.0, 49986.0, 49988.250176246656, 1103.663382668294, 1184.6248272214327, 1214.3988725580894, 1220.1580909172642, 1222.254424800853, 25067.623985639864, 27036.459270814867, 27959.476429915107, 28239.0, 28468.288292792848, 40115.0, 40521.594784051784, 40888.59111408848, 41076.0, 41105.588944110175, 222995.0, 223075.0, 223544.0, 224735.0, 555461.0, 24641.137560185307, 25350.366240844127, 25396.984120634967, 25435.61846572266, 25460.3450775699, 35849.46225806563, 36160.45759313665, 36523.26953460969, 36983.0, 37214.62785372112, 32933.83533082319, 33458.33083338368, 33686.326273474886, 33990.15024624404, 34190.0, 33505.49741753827, 33548.66451335455, 33681.3263734719, 34017.82991085128, 34038.3192336147, 34204.48693269653, 34483.82758086194, 34570.308593828486, 34621.65378346184, 35650.8217458911, 27851.0, 28668.569971450863, 31240.531392028683, 31487.0, 31767.523487148173, 23485.17801876926, 23988.0, 24322.63516047296, 24369.51260974806, 24528.877355613822], "value": 16054.211996281581, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.84995926608974, 380.5547509413986, 386.61145548723533, 388.4290093562464, 394.8894309593315, 15768.369265229392, 16625.667486650276, 17046.914765426154, 17350.132493375342, 17350.652986940284, 15266.923665381686, 15355.155466449369, 16227.91886040571, 16228.43200487983, 16238.431654892052, 4956.553910148095, 5144.871378215537, 5178.482151784829, 5183.766730497136, 5186.611004174683, 3666.4683620874957, 5370.597205209606, 5931.911021334683, 5934.584579079445, 5939.316978547479, 5727.42725727426, 5851.356350801409, 5875.206847075654, 5896.646201227919, 5906.143609176688, 5911.113333000041, 5946.197263369433, 5966.880662386728, 5974.790882319098, 5979.0134627786365, 3365.1755319946524, 3554.91112722184, 3560.3235385276716, 3561.661642143992, 4935.605151587864, 18556.350527731465, 18575.62848743031, 19051.71422428651, 19862.0, 19889.801101988938, 1829.2622307057657, 1879.4173806120145, 1909.484439201408, 1969.4485544047689, 2253.6394176931776, 12259.938700306442, 13066.54267100647, 13238.801417978739, 13318.267495287755, 13548.729025419436, 1804.7834259888766, 1813.2710271042129, 1835.7246413038017, 1838.9816101839078, 1842.81571842816, 69284.0, 70136.6493167536, 70658.0, 71169.6441517789, 72072.0, 9510.239180865514, 9636.807263854824, 9703.66037188695, 9828.950855245677, 9905.207583393456, 13645.044846860625, 13796.241206733524, 13821.447142114404, 13829.861701383059, 13871.791923121162, 7118.537295075804, 7182.0, 7258.927410725825, 7346.52247603904, 7390.0, 6826.146731658543, 6855.520113592001, 6924.584524928419, 6985.860282794316, 7042.295770422917, 6116.113163591343, 6142.477889379364, 6161.907571386433, 6258.687065646699, 6267.122602835607, 1666.516710154066, 1701.3109690575336, 1801.6486785076784, 1811.5199472139893, 1832.4227868221467, 848.7962888906618, 932.8041111366554, 941.0448394879203, 1011.8785745710414, 1021.9693409197736, 16406.0, 16458.259378328003, 16524.421645242357, 16780.0, 16905.0, 847.2925107535154, 894.2309613732185, 895.4285229422322, 899.4378513429107, 930.2743859789375, 9385.343025988252, 9638.084381983841, 9770.120689138012, 9777.608895644094, 9843.852342214872, 396166.0, 409193.31050171354, 418757.0, 418947.0, 420087.0, 76327.0, 77497.22502775013, 78492.60753696309, 78935.0, 80220.59889700514, 941.0683423410774, 944.3531181140941, 957.6025949231131, 960.9183219426427, 964.7925695975399, 15467.0, 15514.0, 15602.375904964128, 15639.983401078893, 15990.920045399698, 33255.0, 33487.49768753422, 33579.49630755492, 34277.48583771195, 34343.31313373768, 47177.7641111806, 47262.0, 47462.0, 47744.0, 47832.282515761595, 7427.331540161412, 7680.615969201406, 7757.2242775724235, 7757.650905709143, 7915.683372665259, 11832.940835296113, 12045.277283363026, 12072.094592905392, 12176.269423834598, 12368.567100151451, 10501.42242176657, 10613.840792387966, 10711.0, 10745.355278683304, 10770.892291077302, 10285.125764310118, 10537.683869483928, 10567.418791966209, 10686.0, 10987.780244395228, 10436.582536698446, 10606.363618182933, 10661.57353705874, 11046.502907369348, 11125.165612578927, 7557.0, 7663.348615367533, 7670.7698769037015, 7750.0699916010435, 7829.491083079582, 9227.953860230924, 9793.167580755431, 10463.68608941733, 10502.267125924136, 10755.677329680122], "value": 8371.728547418763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.6368089573125, 1453.8255409350877, 1466.7286551987881, 1592.800899887514, 1768.4959786460854, 7610.315071643551, 7927.6828926843, 7934.761957141281, 7945.4040946929, 7952.165022672622, 7719.807004824882, 7850.097238817538, 7851.332636725885, 7858.685652573905, 7870.645820938057, 1942.7765806932243, 2011.1151093518804, 2017.1326329678232, 2278.9544209115847, 2309.4226443389152, 2268.2514770125817, 2347.1432926981615, 2350.4241460842118, 2351.988240058797, 2352.0826877517784, 2247.3033359658557, 2260.728712554496, 2272.8977196026217, 2274.647429648399, 2291.8166546676225, 1988.204718112752, 2161.9243326483656, 2261.7172853393326, 2274.4200228941595, 2277.4420267034684, 2285.6685780561893, 2308.4690521180055, 2318.1654604342425, 2319.1998760427628, 2319.7680231976838, 7563.924360756377, 7613.276738709814, 7620.733274335427, 7655.425843061793, 7720.266574675396, 4519.841805536823, 4681.204195286809, 4685.484596694361, 4696.741679207642, 4714.222153344694, 2794.2455537004894, 2840.8863645454157, 2924.356641538858, 2958.363951750384, 2972.7770417218794, 889.6930558957149, 924.8762753254828, 929.5538141691958, 933.8179055084262, 942.0814705661925, 10902.61840835575, 10915.672529824118, 10923.672289831318, 10942.45287735618, 10947.0, 4322.113966636832, 4472.172648060119, 4614.400127983341, 4639.953600463952, 4648.349231107648, 9076.455412675261, 9133.588988495534, 9162.587683554257, 9164.129407706258, 9184.724458266262, 4828.324034635154, 4857.222844344888, 4884.169691152441, 4891.755412229374, 4897.2898929655, 4303.806328715153, 4448.466184057934, 4461.709988850715, 4464.843730469418, 4464.888377790517, 3752.3433399155037, 3774.6036666149657, 3831.9425208621337, 3859.4982652255026, 3890.4164375343357, 1247.5882958623633, 1248.9375531223584, 1250.5560526013317, 1270.6442196185083, 1284.0305569295122, 637.4995628431659, 687.3916583823352, 747.5290566942791, 778.7430148051129, 792.9968589733991, 5076.670016448919, 5091.541761241506, 5146.30524879144, 5266.631335806457, 5345.01117293302, 406.3599830267282, 412.3402555910519, 414.7262806547664, 416.35880743654434, 417.1469345189096, 3572.071261471984, 3676.6507181817683, 3689.409694448929, 3695.667389934919, 3759.1166075972124, 9637.277204209713, 9945.602175913027, 10067.194624430029, 10092.34399764013, 10101.0, 9867.753306167404, 9936.552855121538, 9948.552315145836, 9952.502374881227, 9955.402675839472, 7343.3390994810725, 7591.3926885849, 7638.618069096523, 7651.885221721679, 7691.1924247954275, 5058.342415485963, 5270.341207349082, 5273.0, 5336.919946200733, 5447.673139611636, 9131.452112873249, 9221.262299016196, 9235.538223088954, 9242.029586893279, 9245.075492450702, 8075.596220189084, 8790.692325768823, 9018.639254429749, 9480.0, 9500.667476638284, 6712.093867327848, 6774.085498457645, 6805.693743781443, 6823.215330236888, 6832.59004459734, 7160.534565253241, 7377.372923301579, 7379.0, 7385.519941203805, 7390.630468476447, 6642.070110184482, 6748.122744043243, 6788.86422271542, 6824.965875170592, 6896.620685862325, 6311.873762524816, 6385.106085148176, 6393.6163830170335, 6464.482841372773, 6498.772542960974, 6065.939340606537, 6073.392660733891, 6123.295820980644, 6139.570230083851, 6142.802153580009, 4325.545817689097, 4328.956710432855, 4363.323684828857, 4412.867613971586, 4495.7976891039325, 4382.430284063052, 4401.757903315349, 4452.109578084332, 4465.888352791077, 4471.262241730208], "value": 4099.504692841611, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2607823770614, 319.35649665923165, 321.11052384893844, 331.19189178404673, 331.3703962471306, 5129.640645229013, 5145.4340022597535, 5211.140161873291, 5220.6606570572885, 5225.190095535198, 5136.537711605954, 5159.355080614923, 5163.096458119823, 5171.870703232421, 5204.479552044793, 3834.6357096075826, 3886.1061955750192, 4051.6556092732153, 4082.265192265391, 4099.672026237894, 4057.16828050249, 4089.3048181809013, 4092.6930480214105, 4101.384792281152, 4101.979490102545, 3836.827342769582, 4050.473438452997, 4056.8377264909514, 4064.6748260139266, 4067.8169482373214, 3912.2762288976487, 4048.736832105904, 4056.290149223874, 4060.573639767826, 4061.289274376972, 3572.7677700949357, 3582.8208589570418, 3594.1733401317583, 3598.676119149289, 3620.25784714133, 4904.411470623548, 4908.975455122737, 4916.803327866881, 4928.747026962224, 4937.21004639256, 4562.954370456286, 4643.767811609406, 4681.133990211822, 4683.531646835323, 4692.882677933045, 5427.375851777057, 5429.348478182604, 5442.210879422501, 5453.618246722692, 5464.289642346509, 3930.587288334741, 3941.0, 3947.131631041166, 3955.3869150281753, 3957.3181397905773, 5556.666600003972, 5700.543956483471, 5717.771289148471, 5720.713964301768, 5773.797917072924, 4024.0945787197647, 4045.2314060328445, 4047.696422768245, 4047.846363786307, 4048.3927410888014, 4120.75275483472, 4124.938125928114, 4130.194612050681, 4137.77242251679, 4138.482689663792, 4517.93828450314, 4612.5156858530045, 4654.976725116353, 4656.16189085961, 4659.068186362741, 5438.211459338374, 5447.727613619303, 5456.972715136399, 5467.152591348347, 5474.439784661352, 1414.6463384153963, 1426.2227086238024, 1429.3491017874371, 1429.892758043151, 1434.7274017936559, 904.6291020681489, 948.3266880514911, 977.8705595037743, 980.9166220871306, 999.695092996643, 4675.859724208279, 4680.368150299734, 4686.250199967989, 4688.2733176357715, 4717.0, 5530.198121272393, 5544.584156188302, 5549.1676248562235, 5553.972230138824, 5557.166425036277, 4562.9771851141195, 4740.288956656529, 4749.912556838083, 4753.786079626425, 4790.329353890388, 3013.352129292213, 3038.0885734279627, 3046.1166261783833, 3048.131282584453, 3051.61854768154, 5316.783346075646, 5321.228421878884, 5332.653377530448, 5339.199120131933, 5347.839564813062, 5559.916601250984, 5820.738066787005, 5842.678652674143, 5859.238299021185, 5879.206307148565, 5318.670332416896, 5327.174287985368, 5327.467253274642, 5330.253764473055, 5358.517733404013, 5428.45715428454, 5664.660120392789, 5675.801346952837, 5679.488846003879, 5682.289713785777, 5585.664860108406, 5596.356419011866, 5599.916001259903, 5621.662700237999, 5623.409541998031, 5311.176767601028, 5315.787368505216, 5316.920246196388, 5377.8117765878005, 5378.97310513445, 3849.730518863653, 4041.9797901011484, 4055.8986025349604, 4066.573009834043, 4073.511178658461, 5569.777208911761, 5579.46995035471, 5579.609427340048, 5592.748326325243, 5596.86007849807, 5386.919196212139, 5392.595555333287, 5394.811181608625, 5395.109806881821, 5405.135228346215, 5329.726276279323, 5331.466853314638, 5416.377116631637, 5429.782808687608, 5439.129739241703, 5086.720230387365, 5306.124489459196, 5309.761060752353, 5331.306930099062, 5332.866678333073, 5319.0, 5391.353037635509, 5402.108652072364, 5417.377001644862, 5420.7289635518855, 5346.652467589594, 5368.1679339702405, 5368.516833485005, 5374.731263436891, 5378.112611419228], "value": 4120.660622531837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.1479502671393, 639.7281155508913, 642.8585711143548, 653.8332725155085, 668.5854770042574, 11634.709132271697, 11768.705782355435, 11909.285442873434, 11976.76046479071, 12180.147389682726, 12616.747665046694, 12663.683407914807, 12722.236665800036, 12723.427445764939, 12740.745185096292, 620.4663988969482, 748.4199745197461, 776.3323541754102, 781.4803155901348, 789.3369569561568, 786.7167819584945, 787.6534324897056, 788.4796034617153, 789.5065584009993, 790.3124281874777, 816.6529225079347, 818.2880893622556, 818.3207937411963, 818.5988865455913, 819.6147810529042, 643.0771842406139, 658.4403257231363, 658.6739563915844, 790.9881351779728, 811.7077851973285, 595.2113449679149, 596.2427716799683, 596.3827438601071, 597.6862147372664, 599.307799491588, 12533.874661253452, 12601.30692811895, 12612.243265404106, 12625.810612840814, 12641.178323408949, 11348.829767553494, 11618.767624647544, 11635.534578616845, 11872.40637968098, 11984.0, 9314.534273286308, 9504.42973421597, 9700.854487182698, 9712.0, 9714.90285097147, 3247.0908145719236, 3318.5685860837934, 3359.10983589349, 3363.3105213431186, 3401.557797486336, 46506.767466162455, 46585.0, 47232.7638361806, 47421.288680669815, 48822.755886220344, 8775.0, 8785.780355491164, 8894.110588941054, 8999.100089990949, 9052.547372631341, 16149.677006459806, 16314.75527867083, 16341.509754707378, 16966.915165424092, 17518.0, 6486.318936511599, 6521.184851893513, 6578.046183303394, 6692.5984440932725, 6698.4641228701585, 3683.4658974448553, 3696.611855755161, 3702.555693316819, 3710.9443358349645, 3810.5427348717776, 2880.1791489425414, 2939.559066140096, 2950.79344445891, 2953.926151846221, 2954.1875984104113, 483.3764443867442, 493.5188191513246, 495.8115915951987, 501.90714717777325, 503.6902305082421, 481.32614339923686, 535.922291267764, 561.0210183230289, 584.5352944409204, 596.4810614765096, 6921.273266307066, 7032.718691252395, 7050.964745176344, 7166.670831979627, 7370.668319925616, 453.75497231495285, 534.5937087813212, 534.9251104845247, 540.2922171954751, 554.0940562180783, 3481.9477707834403, 3517.824108794601, 3612.747107702488, 3696.482492451059, 3756.549214094326, 56111.43888561144, 56540.71729641408, 56736.716316418155, 57130.14304785432, 57329.713351432976, 48049.0, 49222.50777492251, 49259.26111108336, 49837.0, 49974.500254997714, 41755.7912210437, 44517.0, 44876.3268550972, 45442.54557454383, 45450.72746362669, 7103.0, 7280.490365674564, 7342.9632851835395, 7550.395968322411, 7572.39420846342, 30324.0, 30670.693293066783, 30731.078067658007, 30814.229644259074, 31328.53007204848, 38367.42448863213, 40387.596124038384, 40753.1849363017, 40895.795521022206, 41018.79490602528, 9125.087491250822, 9170.770730731518, 9401.717948461557, 9510.762230944005, 9534.713958581253, 9994.050565196294, 10031.398116113056, 10211.948940255548, 10370.11853992389, 10718.196135289729, 9869.407835529892, 9986.151177149733, 10339.741506462398, 10494.47527623631, 10626.787464250827, 9741.951290243504, 9787.559559819683, 10469.790604188025, 10538.683839484827, 10627.521761520904, 9481.194098501428, 9530.1899338557, 9636.662716804878, 9649.565769540528, 10090.8486372703, 8885.454318833354, 8891.777705557413, 9088.909110909071, 9107.316951228551, 9316.463770138267, 8143.389245806707, 8212.219839115274, 8741.606627701642, 8787.560621969003, 8792.60433280491], "value": 5688.382104733155, "unit": "score"}], "name": "dromaeo_css", "value": 6242.706811242883, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 107.0, 113.0, 114.0, 115.0, 102.0, 113.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 157.0, 184.0, 133.0, 157.0, 164.0, 133.0, 190.0, 132.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 128.0, 114.0, 74.0, 73.0, 73.0, 130.0, 101.0, 76.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 146.0, 94.0, 94.0, 94.0, 155.0, 93.0, 93.0, 148.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 119.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 148.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 64.0, 67.0, 66.0, 64.0, 91.0, 64.0, 62.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 82.0, 80.0, 83.0, 80.0, 80.0, 80.0, 83.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 143.0, 132.0, 136.0, 135.0, 132.0, 133.0, 133.0, 171.0, 135.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 173.0, 180.0, 175.0, 181.0, 182.0, 182.0, 175.0, 176.0, 177.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 76.0, 73.0, 79.0, 73.0, 73.0, 72.0, 73.0, 72.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1589.8, "alertThreshold": 2.0}]} 05:07:25 INFO - Return code: 0 05:07:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:07:25 ERROR - # TBPL SUCCESS # 05:07:25 INFO - Running post-action listener: _resource_record_post_action 05:07:25 INFO - Running post-run listener: _resource_record_post_run 05:07:26 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 517836800; Read time: 204; Write time: 566912 05:07:26 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234336256; Read time: 0; Write time: 356200 05:07:26 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283500544; Read time: 204; Write time: 210712 05:07:26 INFO - Running post-run listener: _upload_blobber_files 05:07:26 INFO - Blob upload gear active. 05:07:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:26 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 05:07:26 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'] 05:07:26 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 05:07:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:27 INFO - (blobuploader) - INFO - Done attempting. 05:07:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:28 INFO - (blobuploader) - INFO - Done attempting. 05:07:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:28 INFO - Return code: 0 05:07:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35773469caf9e8a3d5c1f25bbe9b14c13575aa4c3018c7df9f95edff663371dca9354ca762c98246ff3ddfa3592f3f74ee24151cda0cf2dbeca9f1b5f66be58d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4fafec0296814cdbdee525bb935a76ce2493c5d524f79769ba53e5f4df1686365c94f9f7ae57ce03868a7e2f9c56ab771a51f06bbb6b79c07bdba98de085368b"} 05:07:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:28 INFO - Contents: 05:07:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35773469caf9e8a3d5c1f25bbe9b14c13575aa4c3018c7df9f95edff663371dca9354ca762c98246ff3ddfa3592f3f74ee24151cda0cf2dbeca9f1b5f66be58d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4fafec0296814cdbdee525bb935a76ce2493c5d524f79769ba53e5f4df1686365c94f9f7ae57ce03868a7e2f9c56ab771a51f06bbb6b79c07bdba98de085368b"} 05:07:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:28 INFO - Copying logs to upload dir... 05:07:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.396207 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-25 05:07:27.694128) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:27.702102) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35773469caf9e8a3d5c1f25bbe9b14c13575aa4c3018c7df9f95edff663371dca9354ca762c98246ff3ddfa3592f3f74ee24151cda0cf2dbeca9f1b5f66be58d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4fafec0296814cdbdee525bb935a76ce2493c5d524f79769ba53e5f4df1686365c94f9f7ae57ce03868a7e2f9c56ab771a51f06bbb6b79c07bdba98de085368b"} build_url:https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35773469caf9e8a3d5c1f25bbe9b14c13575aa4c3018c7df9f95edff663371dca9354ca762c98246ff3ddfa3592f3f74ee24151cda0cf2dbeca9f1b5f66be58d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4fafec0296814cdbdee525bb935a76ce2493c5d524f79769ba53e5f4df1686365c94f9f7ae57ce03868a7e2f9c56ab771a51f06bbb6b79c07bdba98de085368b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:27.729502) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:27.729855) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461584471.880876-1453850281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:27.811905) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:07:27.812208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:07:27.812487) ========= ========= Total master_lag: 0.18 =========