builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1461330463.83 results: success (0) buildid: 20160419230832 builduid: 1ab072c2db0d4b259b7f46e10e93ac05 revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:43.833510) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:43.833985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:43.834262) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:43.850757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:43.851160) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:07:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-04-22 06:07:44 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142366 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:44.007807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:44.008166) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014344 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:44.058054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 06:07:44.058402) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42b25947fc26a0f9eab98d631465b72769553bd --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 d42b25947fc26a0f9eab98d631465b72769553bd --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=c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:07:44,291 truncating revision to first 12 chars 2016-04-22 06:07:44,291 Setting DEBUG logging. 2016-04-22 06:07:44,291 attempt 1/10 2016-04-22 06:07:44,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42b25947fc2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:07:44,584 unpacking tar archive at: fx-team-d42b25947fc2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598557 ========= master_lag: 0.65 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 06:07:45.305126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:45.305462) ========= script_repo_revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:45.305873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:45.306154) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:07:45.317256) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 06:07:45.317675) ========= /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=c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:07:45 INFO - MultiFileLogger online at 20160422 06:07:45 in /builds/slave/test 06:07:45 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 06:07:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:07:45 INFO - {'append_to_log': False, 06:07:45 INFO - 'base_work_dir': '/builds/slave/test', 06:07:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:07:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:07:45 INFO - 'branch': 'Fx-Team-Non-PGO', 06:07:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:07:45 INFO - 'config_files': ('talos/linux_config.py',), 06:07:45 INFO - 'default_actions': ('clobber', 06:07:45 INFO - 'read-buildbot-config', 06:07:45 INFO - 'download-and-extract', 06:07:45 INFO - 'populate-webroot', 06:07:45 INFO - 'create-virtualenv', 06:07:45 INFO - 'install', 06:07:45 INFO - 'run-tests'), 06:07:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:07:45 INFO - 'download_minidump_stackwalk': True, 06:07:45 INFO - 'download_symbols': 'ondemand', 06:07:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:07:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:07:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:07:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:07:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:07:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:07:45 INFO - 'installer_path': 'installer.exe', 06:07:45 INFO - 'log_level': 'info', 06:07:45 INFO - 'log_name': 'talos', 06:07:45 INFO - 'log_to_console': True, 06:07:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:07:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:07:45 INFO - 'opt_config_files': (), 06:07:45 INFO - 'pip_index': False, 06:07:45 INFO - 'sps_profile': False, 06:07:45 INFO - 'sps_profile_interval': 0, 06:07:45 INFO - 'suite': 'dromaeojs', 06:07:45 INFO - 'system_bits': '32', 06:07:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:07:45 INFO - 'title': 'talos-linux64-ix-004', 06:07:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:07:45 INFO - 'use_talos_json': True, 06:07:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:07:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:07:45 INFO - 'work_dir': 'build'} 06:07:45 INFO - ##### 06:07:45 INFO - ##### Running clobber step. 06:07:45 INFO - ##### 06:07:45 INFO - Running pre-action listener: _resource_record_pre_action 06:07:45 INFO - Running main action method: clobber 06:07:45 INFO - rmtree: /builds/slave/test/build 06:07:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:07:46 INFO - Running post-action listener: _resource_record_post_action 06:07:46 INFO - ##### 06:07:46 INFO - ##### Running read-buildbot-config step. 06:07:46 INFO - ##### 06:07:46 INFO - Running pre-action listener: _resource_record_pre_action 06:07:46 INFO - Running main action method: read_buildbot_config 06:07:46 INFO - Using buildbot properties: 06:07:46 INFO - { 06:07:46 INFO - "project": "", 06:07:46 INFO - "product": "firefox", 06:07:46 INFO - "script_repo_revision": "production", 06:07:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:07:46 INFO - "repository": "", 06:07:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:07:46 INFO - "buildid": "20160419230832", 06:07:46 INFO - "pgo_build": "False", 06:07:46 INFO - "basedir": "/builds/slave/test", 06:07:46 INFO - "buildnumber": 1585, 06:07:46 INFO - "slavename": "talos-linux64-ix-004", 06:07:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:07:46 INFO - "platform": "ubuntu64_hw", 06:07:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:07:46 INFO - "branch": "fx-team", 06:07:46 INFO - "repo_path": "integration/fx-team", 06:07:46 INFO - "revision": "d42b25947fc26a0f9eab98d631465b72769553bd", 06:07:46 INFO - "stage_platform": "linux64", 06:07:46 INFO - "builduid": "1ab072c2db0d4b259b7f46e10e93ac05", 06:07:46 INFO - "slavebuilddir": "test" 06:07:46 INFO - } 06:07:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:07:46 INFO - Running post-action listener: _resource_record_post_action 06:07:46 INFO - ##### 06:07:46 INFO - ##### Running download-and-extract step. 06:07:46 INFO - ##### 06:07:46 INFO - Running pre-action listener: _resource_record_pre_action 06:07:46 INFO - Running main action method: download_and_extract 06:07:46 INFO - mkdir: /builds/slave/test/build/tests 06:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:46 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:46 INFO - Downloaded 1361 bytes. 06:07:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:07:46 INFO - Using the following test package requirements: 06:07:46 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:07:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:07:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:07:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:46 INFO - u'jsshell-linux-x86_64.zip'], 06:07:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:07:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:07:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:07:46 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:07:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:07:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:07:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:46 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:47 INFO - Downloaded 22267191 bytes. 06:07:47 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'] 06:07:47 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 06:07:49 INFO - Return code: 0 06:07:49 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 06:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:49 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:50 INFO - Downloaded 22267191 bytes. 06:07:50 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'] 06:07:50 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 06:07:51 INFO - Return code: 0 06:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:51 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:07:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:07:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:07:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:52 INFO - Downloaded 10845952 bytes. 06:07:52 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'] 06:07:52 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 06:07:53 INFO - Return code: 0 06:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:53 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:07:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:07:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:07:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/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 06:07:54 INFO - Downloaded 54589518 bytes. 06:07:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:07:54 INFO - mkdir: /builds/slave/test/properties 06:07:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:07:54 INFO - Writing to file /builds/slave/test/properties/build_url 06:07:54 INFO - Contents: 06:07:54 INFO - build_url:https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:07:55 INFO - Running post-action listener: _resource_record_post_action 06:07:55 INFO - Running post-action listener: set_extra_try_arguments 06:07:55 INFO - ##### 06:07:55 INFO - ##### Running populate-webroot step. 06:07:55 INFO - ##### 06:07:55 INFO - Running pre-action listener: _resource_record_pre_action 06:07:55 INFO - Running main action method: populate_webroot 06:07:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:07:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:07:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:07:55 INFO - '--tppagecycles', 06:07:55 INFO - '7'], 06:07:55 INFO - 'tests': ['tsvgm']}}, 06:07:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:07:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:07:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:07:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:07:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:55 INFO - 'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:55 INFO - 'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['damp', 'tps']}, 06:07:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:55 INFO - 'tests': ['damp', 'tps']}, 06:07:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['dromaeo_dom']}, 06:07:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:07:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['a11yr', 06:07:55 INFO - 'ts_paint', 06:07:55 INFO - 'tpaint', 06:07:55 INFO - 'sessionrestore', 06:07:55 INFO - 'sessionrestore_no_auto_restore', 06:07:55 INFO - 'tabpaint']}, 06:07:55 INFO - 'other-e10s': {'tests': ['a11yr', 06:07:55 INFO - 'ts_paint', 06:07:55 INFO - 'tpaint', 06:07:55 INFO - 'sessionrestore', 06:07:55 INFO - 'sessionrestore_no_auto_restore', 06:07:55 INFO - 'tabpaint']}, 06:07:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:07:55 INFO - 'ts_paint', 06:07:55 INFO - 'tpaint', 06:07:55 INFO - 'sessionrestore', 06:07:55 INFO - 'sessionrestore_no_auto_restore', 06:07:55 INFO - 'tabpaint']}, 06:07:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:07:55 INFO - 'ts_paint', 06:07:55 INFO - 'tpaint', 06:07:55 INFO - 'sessionrestore', 06:07:55 INFO - 'sessionrestore_no_auto_restore', 06:07:55 INFO - 'tabpaint']}, 06:07:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['a11yr', 06:07:55 INFO - 'ts_paint', 06:07:55 INFO - 'tpaint', 06:07:55 INFO - 'sessionrestore', 06:07:55 INFO - 'sessionrestore_no_auto_restore', 06:07:55 INFO - 'tabpaint']}, 06:07:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['a11yr', 06:07:55 INFO - 'ts_paint', 06:07:55 INFO - 'tpaint', 06:07:55 INFO - 'sessionrestore', 06:07:55 INFO - 'sessionrestore_no_auto_restore', 06:07:55 INFO - 'tabpaint']}, 06:07:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['tsvgx', 06:07:55 INFO - 'tsvgr_opacity', 06:07:55 INFO - 'tart', 06:07:55 INFO - 'tscrollx', 06:07:55 INFO - 'cart']}, 06:07:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:07:55 INFO - 'tsvgr_opacity', 06:07:55 INFO - 'tart', 06:07:55 INFO - 'tscrollx', 06:07:55 INFO - 'cart']}, 06:07:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:55 INFO - 'talos_options': ['--disable-e10s'], 06:07:55 INFO - 'tests': ['tp5o']}, 06:07:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:55 INFO - 'tests': ['tp5o']}, 06:07:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:55 INFO - 'talos_options': ['--disable-e10s', 06:07:55 INFO - '--xperf_path', 06:07:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:55 INFO - 'tests': ['tp5n']}, 06:07:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:55 INFO - 'talos_options': ['--xperf_path', 06:07:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:55 INFO - 'tests': ['tp5n']}}, 06:07:55 INFO - 'talos.zip': {'path': '', 06:07:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:07:55 INFO - Running post-action listener: _resource_record_post_action 06:07:55 INFO - ##### 06:07:55 INFO - ##### Running create-virtualenv step. 06:07:55 INFO - ##### 06:07:55 INFO - Running pre-action listener: _resource_record_pre_action 06:07:55 INFO - Running main action method: create_virtualenv 06:07:55 INFO - Creating virtualenv /builds/slave/test/build/venv 06:07:55 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 06:07:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:07:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:07:55 INFO - Using real prefix '/usr' 06:07:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:07:56 INFO - Installing distribute.............................................................................................................................................................................................done. 06:07:58 INFO - Installing pip.................done. 06:07:58 INFO - Return code: 0 06:07:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:58 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 0x7f0d846a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', '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 06:07:58 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 06:07:58 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 06:07:58 INFO - Using env: {'DISPLAY': ':0', 06:07:58 INFO - 'HOME': '/home/cltbld', 06:07:58 INFO - 'LANG': 'en_US.UTF-8', 06:07:58 INFO - 'LANGUAGE': 'en_US:en', 06:07:58 INFO - 'LOGNAME': 'cltbld', 06:07:58 INFO - 'MAIL': '/var/mail/cltbld', 06:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:58 INFO - 'MOZ_NO_REMOTE': '1', 06:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:58 INFO - 'NO_EM_RESTART': '1', 06:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:58 INFO - 'PWD': '/builds/slave/test', 06:07:58 INFO - 'SHELL': '/bin/bash', 06:07:58 INFO - 'SHLVL': '1', 06:07:58 INFO - 'TERM': 'linux', 06:07:58 INFO - 'TMOUT': '86400', 06:07:58 INFO - 'USER': 'cltbld', 06:07:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:58 INFO - '_': '/tools/buildbot/bin/python'} 06:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:58 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 06:07:58 INFO - Cleaning up... 06:07:58 INFO - Return code: 0 06:07:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:58 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 0x7f0d846a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', '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 06:07:58 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 06:07:58 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 06:07:58 INFO - Using env: {'DISPLAY': ':0', 06:07:58 INFO - 'HOME': '/home/cltbld', 06:07:58 INFO - 'LANG': 'en_US.UTF-8', 06:07:58 INFO - 'LANGUAGE': 'en_US:en', 06:07:58 INFO - 'LOGNAME': 'cltbld', 06:07:58 INFO - 'MAIL': '/var/mail/cltbld', 06:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:58 INFO - 'MOZ_NO_REMOTE': '1', 06:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:58 INFO - 'NO_EM_RESTART': '1', 06:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:58 INFO - 'PWD': '/builds/slave/test', 06:07:58 INFO - 'SHELL': '/bin/bash', 06:07:58 INFO - 'SHLVL': '1', 06:07:58 INFO - 'TERM': 'linux', 06:07:58 INFO - 'TMOUT': '86400', 06:07:58 INFO - 'USER': 'cltbld', 06:07:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:58 INFO - '_': '/tools/buildbot/bin/python'} 06:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:58 INFO - Downloading/unpacking psutil>=0.7.1 06:07:58 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 06:07:58 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 06:07:58 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 06:07:58 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 06:07:58 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 06:07:58 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 06:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:08:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:00 INFO - Installing collected packages: psutil 06:08:00 INFO - Running setup.py install for psutil 06:08:00 INFO - building 'psutil._psutil_linux' extension 06:08:00 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 06:08:00 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 06:08:00 INFO - building 'psutil._psutil_posix' extension 06:08:00 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 06:08:01 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 06:08:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:01 INFO - Successfully installed psutil 06:08:01 INFO - Cleaning up... 06:08:01 INFO - Return code: 0 06:08:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:08:01 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')]} 06:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:01 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')]} 06:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:01 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 0x7f0d846a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', '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 06:08:01 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 06:08:01 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 06:08:01 INFO - Using env: {'DISPLAY': ':0', 06:08:01 INFO - 'HOME': '/home/cltbld', 06:08:01 INFO - 'LANG': 'en_US.UTF-8', 06:08:01 INFO - 'LANGUAGE': 'en_US:en', 06:08:01 INFO - 'LOGNAME': 'cltbld', 06:08:01 INFO - 'MAIL': '/var/mail/cltbld', 06:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:01 INFO - 'MOZ_NO_REMOTE': '1', 06:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:01 INFO - 'NO_EM_RESTART': '1', 06:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:01 INFO - 'PWD': '/builds/slave/test', 06:08:01 INFO - 'SHELL': '/bin/bash', 06:08:01 INFO - 'SHLVL': '1', 06:08:01 INFO - 'TERM': 'linux', 06:08:01 INFO - 'TMOUT': '86400', 06:08:01 INFO - 'USER': 'cltbld', 06:08:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:01 INFO - '_': '/tools/buildbot/bin/python'} 06:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:08:01 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 06:08:01 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 06:08:01 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 06:08:01 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 06:08:01 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 06:08:01 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 06:08:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:08:03 INFO - Installing collected packages: mozsystemmonitor 06:08:03 INFO - Running setup.py install for mozsystemmonitor 06:08:03 INFO - Successfully installed mozsystemmonitor 06:08:03 INFO - Cleaning up... 06:08:03 INFO - Return code: 0 06:08:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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', '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 0x7f0d846a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', '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 06:08: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:08: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 blobuploader==1.2.4 06:08:03 INFO - Using env: {'DISPLAY': ':0', 06:08:03 INFO - 'HOME': '/home/cltbld', 06:08:03 INFO - 'LANG': 'en_US.UTF-8', 06:08:03 INFO - 'LANGUAGE': 'en_US:en', 06:08:03 INFO - 'LOGNAME': 'cltbld', 06:08:03 INFO - 'MAIL': '/var/mail/cltbld', 06:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:03 INFO - 'MOZ_NO_REMOTE': '1', 06:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:03 INFO - 'NO_EM_RESTART': '1', 06:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:03 INFO - 'PWD': '/builds/slave/test', 06:08:03 INFO - 'SHELL': '/bin/bash', 06:08:03 INFO - 'SHLVL': '1', 06:08:03 INFO - 'TERM': 'linux', 06:08:03 INFO - 'TMOUT': '86400', 06:08:03 INFO - 'USER': 'cltbld', 06:08:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:03 INFO - '_': '/tools/buildbot/bin/python'} 06:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:08:03 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 06:08:03 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 06:08:03 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 06:08:03 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 06:08:03 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 06:08:03 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 06:08:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:08:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:08:05 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 06:08:05 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 06:08:05 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 06:08:05 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 06:08:05 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 06:08:05 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 06:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:08:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:08:06 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 06:08:06 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 06:08:06 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 06:08:06 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 06:08:06 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 06:08:06 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 06:08:06 INFO - Downloading docopt-0.6.1.tar.gz 06:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:08:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:08:06 INFO - Running setup.py install for blobuploader 06:08:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:08:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:08:06 INFO - Running setup.py install for requests 06:08:06 INFO - Running setup.py install for docopt 06:08:06 INFO - Successfully installed blobuploader requests docopt 06:08:06 INFO - Cleaning up... 06:08:07 INFO - Return code: 0 06:08:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:07 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')]} 06:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:07 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')]} 06:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:07 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 0x7f0d846a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', '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 06:08:07 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 06:08:07 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 06:08:07 INFO - Using env: {'DISPLAY': ':0', 06:08:07 INFO - 'HOME': '/home/cltbld', 06:08:07 INFO - 'LANG': 'en_US.UTF-8', 06:08:07 INFO - 'LANGUAGE': 'en_US:en', 06:08:07 INFO - 'LOGNAME': 'cltbld', 06:08:07 INFO - 'MAIL': '/var/mail/cltbld', 06:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:07 INFO - 'MOZ_NO_REMOTE': '1', 06:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:07 INFO - 'NO_EM_RESTART': '1', 06:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:07 INFO - 'PWD': '/builds/slave/test', 06:08:07 INFO - 'SHELL': '/bin/bash', 06:08:07 INFO - 'SHLVL': '1', 06:08:07 INFO - 'TERM': 'linux', 06:08:07 INFO - 'TMOUT': '86400', 06:08:07 INFO - 'USER': 'cltbld', 06:08:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:07 INFO - '_': '/tools/buildbot/bin/python'} 06:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:07 INFO - Running setup.py (path:/tmp/pip-Pb4MqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:07 INFO - Running setup.py (path:/tmp/pip-Rg8spK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:07 INFO - Running setup.py (path:/tmp/pip-nWc4Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:07 INFO - Running setup.py (path:/tmp/pip-H__YW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:07 INFO - Running setup.py (path:/tmp/pip-tVfqrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:07 INFO - Running setup.py (path:/tmp/pip-yNRmls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:07 INFO - Running setup.py (path:/tmp/pip-JcmQgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:07 INFO - Running setup.py (path:/tmp/pip-aDQuDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:07 INFO - Running setup.py (path:/tmp/pip-BDuBxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:07 INFO - Running setup.py (path:/tmp/pip-I0t8Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:07 INFO - Running setup.py (path:/tmp/pip-RTx7eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:08 INFO - Running setup.py (path:/tmp/pip-uq2t6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:08 INFO - Running setup.py (path:/tmp/pip-lryZ4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:08 INFO - Running setup.py (path:/tmp/pip-ibVLhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:08 INFO - Running setup.py (path:/tmp/pip-IOURBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:08 INFO - Running setup.py (path:/tmp/pip-YF6UCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:08 INFO - Running setup.py (path:/tmp/pip-OTY4Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:08:08 INFO - Running setup.py install for manifestparser 06:08:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:08:08 INFO - Running setup.py install for mozcrash 06:08:08 INFO - Running setup.py install for mozdebug 06:08:08 INFO - Running setup.py install for mozdevice 06:08:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:08:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:08:08 INFO - Running setup.py install for mozfile 06:08:08 INFO - Running setup.py install for mozhttpd 06:08:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Running setup.py install for mozinfo 06:08:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Running setup.py install for mozInstall 06:08:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Running setup.py install for mozleak 06:08:09 INFO - Running setup.py install for mozlog 06:08:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Running setup.py install for moznetwork 06:08:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Running setup.py install for mozprocess 06:08:09 INFO - Running setup.py install for mozprofile 06:08:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Running setup.py install for mozrunner 06:08:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:08:09 INFO - Running setup.py install for mozscreenshot 06:08:10 INFO - Running setup.py install for moztest 06:08:10 INFO - Running setup.py install for mozversion 06:08:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:08:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:08:10 INFO - Cleaning up... 06:08:10 INFO - Return code: 0 06:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:10 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 0x7f0d846a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', '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 06:08:10 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 06:08:10 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 06:08:10 INFO - Using env: {'DISPLAY': ':0', 06:08:10 INFO - 'HOME': '/home/cltbld', 06:08:10 INFO - 'LANG': 'en_US.UTF-8', 06:08:10 INFO - 'LANGUAGE': 'en_US:en', 06:08:10 INFO - 'LOGNAME': 'cltbld', 06:08:10 INFO - 'MAIL': '/var/mail/cltbld', 06:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:10 INFO - 'MOZ_NO_REMOTE': '1', 06:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:10 INFO - 'NO_EM_RESTART': '1', 06:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:10 INFO - 'PWD': '/builds/slave/test', 06:08:10 INFO - 'SHELL': '/bin/bash', 06:08:10 INFO - 'SHLVL': '1', 06:08:10 INFO - 'TERM': 'linux', 06:08:10 INFO - 'TMOUT': '86400', 06:08:10 INFO - 'USER': 'cltbld', 06:08:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:10 INFO - '_': '/tools/buildbot/bin/python'} 06:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:10 INFO - Running setup.py (path:/tmp/pip-jShUlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:10 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)) 06:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:10 INFO - Running setup.py (path:/tmp/pip-w9bd_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:10 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)) 06:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:10 INFO - Running setup.py (path:/tmp/pip-i5usc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:10 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)) 06:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:10 INFO - Running setup.py (path:/tmp/pip-DPQoKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:10 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)) 06:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:10 INFO - Running setup.py (path:/tmp/pip-PW8QuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:10 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)) 06:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:10 INFO - Running setup.py (path:/tmp/pip-uVykve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:10 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)) 06:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:10 INFO - Running setup.py (path:/tmp/pip-ybXGFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:10 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)) 06:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:10 INFO - Running setup.py (path:/tmp/pip-qCChgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:11 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)) 06:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:11 INFO - Running setup.py (path:/tmp/pip-WKdYAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:11 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)) 06:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:11 INFO - Running setup.py (path:/tmp/pip-ekyJo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:11 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)) 06:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:11 INFO - Running setup.py (path:/tmp/pip-qBOVQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:11 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)) 06:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:11 INFO - Running setup.py (path:/tmp/pip-1MIB5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:11 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)) 06:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:11 INFO - Running setup.py (path:/tmp/pip-z6eEkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:11 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)) 06:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:11 INFO - Running setup.py (path:/tmp/pip-FHPVvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:11 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)) 06:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:11 INFO - Running setup.py (path:/tmp/pip-x79kod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:11 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)) 06:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:11 INFO - Running setup.py (path:/tmp/pip-xv4HnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:11 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)) 06:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:11 INFO - Running setup.py (path:/tmp/pip-_AzLvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:11 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)) 06:08:11 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)) 06:08:11 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)) 06:08:11 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)) 06:08:11 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)) 06:08:11 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)) 06:08:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08:13 INFO - Downloading blessings-1.6.tar.gz 06:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:08:13 INFO - Installing collected packages: blessings 06:08:13 INFO - Running setup.py install for blessings 06:08:13 INFO - Successfully installed blessings 06:08:13 INFO - Cleaning up... 06:08:13 INFO - Return code: 0 06:08:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:08:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:14 INFO - Reading from file tmpfile_stdout 06:08:14 INFO - Current package versions: 06:08:14 INFO - argparse == 1.2.1 06:08:14 INFO - blessings == 1.6 06:08:14 INFO - blobuploader == 1.2.4 06:08:14 INFO - docopt == 0.6.1 06:08:14 INFO - manifestparser == 1.1 06:08:14 INFO - mozInstall == 1.12 06:08:14 INFO - mozcrash == 0.17 06:08:14 INFO - mozdebug == 0.1 06:08:14 INFO - mozdevice == 0.48 06:08:14 INFO - mozfile == 1.2 06:08:14 INFO - mozhttpd == 0.7 06:08:14 INFO - mozinfo == 0.9 06:08:14 INFO - mozleak == 0.1 06:08:14 INFO - mozlog == 3.1 06:08:14 INFO - moznetwork == 0.27 06:08:14 INFO - mozprocess == 0.22 06:08:14 INFO - mozprofile == 0.28 06:08:14 INFO - mozrunner == 6.11 06:08:14 INFO - mozscreenshot == 0.1 06:08:14 INFO - mozsystemmonitor == 0.0 06:08:14 INFO - moztest == 0.7 06:08:14 INFO - mozversion == 1.4 06:08:14 INFO - psutil == 3.1.1 06:08:14 INFO - requests == 1.2.3 06:08:14 INFO - wsgiref == 0.1.2 06:08:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:14 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 0x7f0d846a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', '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 06:08:14 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 06:08:14 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 06:08:14 INFO - Using env: {'DISPLAY': ':0', 06:08:14 INFO - 'HOME': '/home/cltbld', 06:08:14 INFO - 'LANG': 'en_US.UTF-8', 06:08:14 INFO - 'LANGUAGE': 'en_US:en', 06:08:14 INFO - 'LOGNAME': 'cltbld', 06:08:14 INFO - 'MAIL': '/var/mail/cltbld', 06:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:14 INFO - 'MOZ_NO_REMOTE': '1', 06:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:14 INFO - 'NO_EM_RESTART': '1', 06:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:14 INFO - 'PWD': '/builds/slave/test', 06:08:14 INFO - 'SHELL': '/bin/bash', 06:08:14 INFO - 'SHLVL': '1', 06:08:14 INFO - 'TERM': 'linux', 06:08:14 INFO - 'TMOUT': '86400', 06:08:14 INFO - 'USER': 'cltbld', 06:08:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:14 INFO - '_': '/tools/buildbot/bin/python'} 06:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:14 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)) 06:08:14 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)) 06:08:14 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)) 06:08:14 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)) 06:08:14 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)) 06:08:14 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)) 06:08:14 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)) 06:08:14 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)) 06:08:14 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)) 06:08:14 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)) 06:08:14 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)) 06:08:14 INFO - Cleaning up... 06:08:14 INFO - Return code: 0 06:08:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d846a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', '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 06:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:08:14 INFO - Using env: {'DISPLAY': ':0', 06:08:14 INFO - 'HOME': '/home/cltbld', 06:08:14 INFO - 'LANG': 'en_US.UTF-8', 06:08:14 INFO - 'LANGUAGE': 'en_US:en', 06:08:14 INFO - 'LOGNAME': 'cltbld', 06:08:14 INFO - 'MAIL': '/var/mail/cltbld', 06:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:14 INFO - 'MOZ_NO_REMOTE': '1', 06:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:14 INFO - 'NO_EM_RESTART': '1', 06:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:14 INFO - 'PWD': '/builds/slave/test', 06:08:14 INFO - 'SHELL': '/bin/bash', 06:08:14 INFO - 'SHLVL': '1', 06:08:14 INFO - 'TERM': 'linux', 06:08:14 INFO - 'TMOUT': '86400', 06:08:14 INFO - 'USER': 'cltbld', 06:08:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:14 INFO - '_': '/tools/buildbot/bin/python'} 06:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:14 INFO - Downloading/unpacking jsonschema 06:08:14 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 06:08:14 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 06:08:14 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 06:08:14 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 06:08:14 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 06:08:14 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 06:08:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:08:16 INFO - Downloading/unpacking functools32 (from jsonschema) 06:08:16 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 06:08:16 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 06:08:16 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 06:08:16 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 06:08:16 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 06:08:16 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 06:08:16 INFO - Downloading functools32-3.2.3-2.tar.gz 06:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:08:16 INFO - warning: no files found matching '*.txt' 06:08:16 INFO - no previously-included directories found matching 'build' 06:08:16 INFO - no previously-included directories found matching 'dist' 06:08:16 INFO - no previously-included directories found matching '.git*' 06:08:16 INFO - Installing collected packages: jsonschema, functools32 06:08:16 INFO - Running setup.py install for functools32 06:08:16 INFO - warning: no files found matching '*.txt' 06:08:16 INFO - no previously-included directories found matching 'build' 06:08:16 INFO - no previously-included directories found matching 'dist' 06:08:16 INFO - no previously-included directories found matching '.git*' 06:08:16 INFO - Successfully installed jsonschema functools32 06:08:16 INFO - Cleaning up... 06:08:17 INFO - Return code: 0 06:08:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d846a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdba7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', '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 06:08:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:08:17 INFO - Using env: {'DISPLAY': ':0', 06:08:17 INFO - 'HOME': '/home/cltbld', 06:08:17 INFO - 'LANG': 'en_US.UTF-8', 06:08:17 INFO - 'LANGUAGE': 'en_US:en', 06:08:17 INFO - 'LOGNAME': 'cltbld', 06:08:17 INFO - 'MAIL': '/var/mail/cltbld', 06:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:17 INFO - 'MOZ_NO_REMOTE': '1', 06:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:17 INFO - 'NO_EM_RESTART': '1', 06:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:17 INFO - 'PWD': '/builds/slave/test', 06:08:17 INFO - 'SHELL': '/bin/bash', 06:08:17 INFO - 'SHLVL': '1', 06:08:17 INFO - 'TERM': 'linux', 06:08:17 INFO - 'TMOUT': '86400', 06:08:17 INFO - 'USER': 'cltbld', 06:08:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:17 INFO - '_': '/tools/buildbot/bin/python'} 06:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:17 INFO - Downloading/unpacking flake8 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:08:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:08:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 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 06:08:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:19 INFO - no previously-included directories found matching 'docs/_build' 06:08:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:08:19 INFO - Running setup.py install for pep8 06:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:19 INFO - no previously-included directories found matching 'docs/_build' 06:08:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:08:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:08:20 INFO - Cleaning up... 06:08:20 INFO - Return code: 0 06:08:20 INFO - Running post-action listener: _resource_record_post_action 06:08:20 INFO - Running post-action listener: _start_resource_monitoring 06:08:20 INFO - Starting resource monitoring. 06:08:20 INFO - ##### 06:08:20 INFO - ##### Running install step. 06:08:20 INFO - ##### 06:08:20 INFO - Running pre-action listener: _resource_record_pre_action 06:08:20 INFO - Running main action method: install 06:08:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:20 INFO - Reading from file tmpfile_stdout 06:08:20 INFO - Detecting whether we're running mozinstall >=1.0... 06:08:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:08:20 INFO - Reading from file tmpfile_stdout 06:08:20 INFO - Output received: 06:08:20 INFO - Usage: mozinstall [options] installer 06:08:20 INFO - Options: 06:08:20 INFO - -h, --help show this help message and exit 06:08:20 INFO - -d DEST, --destination=DEST 06:08:20 INFO - Directory to install application into. [default: 06:08:20 INFO - "/builds/slave/test"] 06:08:20 INFO - --app=APP Application being installed. [default: firefox] 06:08:20 INFO - mkdir: /builds/slave/test/build/application 06:08:20 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'] 06:08:20 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 06:08:36 INFO - Reading from file tmpfile_stdout 06:08:36 INFO - Output received: 06:08:36 INFO - /builds/slave/test/build/application/firefox/firefox 06:08:36 INFO - Running post-action listener: _resource_record_post_action 06:08:36 INFO - ##### 06:08:36 INFO - ##### Running run-tests step. 06:08:36 INFO - ##### 06:08:36 INFO - Running pre-action listener: _resource_record_pre_action 06:08:36 INFO - Running main action method: run_tests 06:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:08:36 INFO - Python 2.7.3 06:08:36 INFO - Return code: 0 06:08:36 INFO - grabbing minidump binary from tooltool 06:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:36 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 0xe49640>, '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 0xe4a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4a9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:08:36 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 06:08:36 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 06:08:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:08:36 INFO - Return code: 0 06:08:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:08:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:08:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:08:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:08:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:08:37 INFO - Return code: 0 06:08:37 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/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 06:08:37 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/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 06:08:37 INFO - Using env: {'DISPLAY': ':0', 06:08:37 INFO - 'HOME': '/home/cltbld', 06:08:37 INFO - 'LANG': 'en_US.UTF-8', 06:08:37 INFO - 'LANGUAGE': 'en_US:en', 06:08:37 INFO - 'LOGNAME': 'cltbld', 06:08:37 INFO - 'MAIL': '/var/mail/cltbld', 06:08:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:08:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:37 INFO - 'MOZ_NO_REMOTE': '1', 06:08:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:37 INFO - 'NO_EM_RESTART': '1', 06:08:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:37 INFO - 'PWD': '/builds/slave/test', 06:08:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:08:37 INFO - 'SHELL': '/bin/bash', 06:08:37 INFO - 'SHLVL': '1', 06:08:37 INFO - 'TERM': 'linux', 06:08:37 INFO - 'TMOUT': '86400', 06:08:37 INFO - 'USER': 'cltbld', 06:08:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043', 06:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:37 INFO - '_': '/tools/buildbot/bin/python'} 06:08:37 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/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 06:08:37 INFO - mozversion application_buildid: 20160419230832 06:08:37 INFO - mozversion application_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 06:08:37 INFO - mozversion application_display_name: Nightly 06:08:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:08:37 INFO - mozversion application_name: Firefox 06:08:37 INFO - mozversion application_remotingname: firefox 06:08:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:08:37 INFO - mozversion application_vendor: Mozilla 06:08:37 INFO - mozversion application_version: 48.0a1 06:08:37 INFO - mozversion platform_buildid: 20160419230832 06:08:37 INFO - mozversion platform_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 06:08:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:08:37 INFO - mozversion platform_version: 48.0a1 06:08:37 INFO - using testdate: 1461330517 06:08:37 INFO - actual date: 1461330517 06:08:37 INFO - starting webserver on 'localhost:60417' 06:08:37 INFO - SUITE-START | Running 2 tests 06:08:37 INFO - TEST-START | dromaeo_css 06:08:37 INFO - operating with platform_type : linux_ 06:08:37 INFO - Initialising browser for dromaeo_css test... 06:08:37 INFO - TEST-INFO | started process 28753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6eYN2L/profile http://localhost:60417/getInfo.html) 06:08:41 INFO - PROCESS | 28753 | __metrics Screen width/height:1600/1200 06:08:41 INFO - PROCESS | 28753 | colorDepth:24 06:08:41 INFO - PROCESS | 28753 | Browser inner width/height: 1024/697 06:08:41 INFO - PROCESS | 28753 | __metrics 06:08:43 ERROR - PROCESS | 28753 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:08:43 INFO - TEST-INFO | 28753: exit 0 06:08:43 INFO - Browser initialized. 06:08:43 INFO - Running cycle 1/1 for dromaeo_css test... 06:08:43 INFO - TEST-INFO | started process 28833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6eYN2L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:55 INFO - PROCESS | 28833 | RSS: Main: 155254784 06:08:55 INFO - PROCESS | 28833 | 06:09:47 INFO - PROCESS | 28833 | 1461330587446 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] 06:11:59 INFO - PROCESS | 28833 | Cycle 1(1): loaded http://localhost:60417/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60417/tests/dromaeo/cssquery-ext.html) 06:12:00 INFO - PROCESS | 28833 | RSS: Main: 262922240 06:12:00 INFO - PROCESS | 28833 | 06:15:02 INFO - PROCESS | 28833 | Cycle 1(1): loaded http://localhost:60417/tests/dromaeo/cssquery-ext.html (next: http://localhost:60417/tests/dromaeo/cssquery-jquery.html) 06:15:03 INFO - PROCESS | 28833 | RSS: Main: 238882816 06:15:03 INFO - PROCESS | 28833 | 06:18:05 INFO - PROCESS | 28833 | Cycle 1(1): loaded http://localhost:60417/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60417/tests/dromaeo/cssquery-mootools.html) 06:18:06 INFO - PROCESS | 28833 | RSS: Main: 237637632 06:18:06 INFO - PROCESS | 28833 | 06:21:08 INFO - PROCESS | 28833 | Cycle 1(1): loaded http://localhost:60417/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60417/tests/dromaeo/cssquery-prototype.html) 06:21:08 INFO - PROCESS | 28833 | RSS: Main: 230105088 06:21:08 INFO - PROCESS | 28833 | 06:24:11 INFO - PROCESS | 28833 | Cycle 1(1): loaded http://localhost:60417/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60417/tests/dromaeo/cssquery-yui.html) 06:24:12 INFO - PROCESS | 28833 | RSS: Main: 210538496 06:24:12 INFO - PROCESS | 28833 | 06:27:15 INFO - PROCESS | 28833 | Cycle 1(1): loaded http://localhost:60417/tests/dromaeo/cssquery-yui.html (next: http://localhost:60417/tests/dromaeo/cssquery-dojo.html) 06:27:15 INFO - PROCESS | 28833 | RSS: Main: 268578816 06:27:15 INFO - PROCESS | 28833 | 06:27:15 INFO - PROCESS | 28833 | __start_tp_report 06:27:15 INFO - PROCESS | 28833 | _x_x_mozilla_page_load 06:27:15 INFO - PROCESS | 28833 | _x_x_mozilla_page_load_details 06:27:15 INFO - PROCESS | 28833 | |i|pagename|runs| 06:27:15 INFO - PROCESS | 28833 | |0;dojo.html;2562.923112306631;2658.7341265873415;2672.9064482743097;2686.9059582914597;2688.5832695932113;4464.799084041218;4561.863144105674;4600.079984003196;4615.630749540037;4631.7915693793775;4582.495925448198;4605.769711514427;4613.423322084739;4685.578297953183;4700.670953033289;4206.978965105171;4225.8732238032835;4251.638610718092;4291.9570804292025;4361.476622805268;4293.742375457467;4316.784160791948;4329.935050974238;4357.651387888977;4370.3007518797;4136;4210.578942105795;4224.493060832689;4246.80889359978;4313.741175529478;4213.47331583552;4246.893827654333;4247.27796274631;4273.957260427387;4293.48478182617;4178.331466965301;4201.537830838605;4220.07158425146;4225.9788701056605;4262.893427664302;4388.561143885618;4475.955240447586;4513.232750432434;4536.478304994935;4573.039661671053;4928.926066109011;4931.506849315076;4937.851864444073;4941.777620007108;4973.403191616993;4949.727764972925;4971.527704868032;4974.676646017997;4978.427480839714;5029.2958985742025;4439.400680908101;4590.150822097922;4655.162070827249;4695.131400690815;4708.599769019672;5018.272350509229;5041.697498150123;5045.823396181189;5051.747412629354;5071.568916642127;4827.589654879304;4836.202026665561;4837.22604383304;4845.127876982177;4873.780679869415;4719.480857105716;4814.807407703723;4887;4909.533594308535;4914.140025495524;4871.853844384674;4873.074115917964;4884.780184891689;4901.362822833009;4947;4848.442429120626;4861.878453038632;4876.171050921281;4880.585150262196;4934.037862616827;4054.1486287879284;4121.361189015707;4133.028738246509;4226.894327641833;4235.195312890541;3663.2307215484516;3670.302642497917;3670.4127339625534;3709.27669104522;3723.2181241938956;4268.871933841928;4271.957280427218;4273.743575385487;4306.461692288464;4318.373835793793;4733.5503127202865;4845.200541910545;4920.21276595743;4931.087748766489;4948.05986862495;4256.127493863751;4272.230998420314;4292.356146577976;4312.029793296546;4323.005708687019;4409.581089796464;4453.087117140978;4455.064436468378;4459.44256967879;4498.730076195438;4483.461984561874;4655.092257009851;4685.6017238535105;4726.503717109654;4726.976365118152;4954.479779623088;4954.554090131761;4975.353204083446;4992.900141997067;5007.69953802773;4733.3373327734835;4735.266033764772;4740.099381117715;4756.357891684578;4796.2805579163405;4670.462896766915;4780.235162374003;4841.782119804547;4856.975715121402;4857.222844344888;4887.242477416006;4903.934308606;4911.607071434348;4920.92618610714;4941.209406494943;4764;4783.593394561502;4790.664653474363;4805.735684537384;4840.7337596432535;4577.1074640444795;4698.624110071254;4768.523147685204;4792.808287668454;4800.711957282574;4697.8355757548325;4705.6000239979985;4723.480417154179;4729.692569983078;4779.808807647655;4818.445878723992;4820.68665536753;4834.516548345137;4835.3714017178945;4879.853604391874;4554.954450455453;4704.458987216514;4788.592969597484;4792.520747925179;4803.975980120077 06:27:15 INFO - PROCESS | 28833 | |1;ext.html;563.7773079633545;596.6777939912445;601.3024891126294;612.2775125352083;613.7422282641292;26400.735992640068;33958.830205848964;35296.11759706009;35348.11629709259;35360.64639353609;37687.434688479625;38577;38609;38689.226215475675;38732.99999999993;7233.276672332777;7582.090149182106;7842.451028427984;9444.48055356955;9775.31572789905;9637.277204209677;9764.12122908938;9770.218382529416;9771.267154963407;9774.706758797247;9775.902240977606;9859.260555458333;9865.112139907407;9866.408015519057;9867.506624668773;9771.316007879452;9820.263480238938;9829.557669904836;9834.655787047419;9839.704808855746;9714.31999760017;9815.509224538744;9818.26363022776;10055.849162262572;10075.244356673278;37207.62792372068;37674.81162594169;37699.81150094232;37706.24587508262;37735.43396849049;3224.7258982986473;3316.3533111043357;3329.783564068328;3410.9147271318166;3587.443946188348;28170;28456.573151402747;28572.857135714396;28801.71198288011;29787.55318670222;3152.921176970571;3165.9208519786957;3189.202699325169;3212.3093534889877;3261.6901394367733;209380;212305;212753;212870;213890;53666.73166634142;54325.45674543283;54372;54453.45546544563;54558.727206363714;57142.42857571454;57236.14145787816;57292;57467.712661436424;57506.13740793891;12467.314297713712;12925.612231633066;12942.547010854574;12943.158694684815;12947.935260323826;10497.737556561147;10527.84208236877;10549.314294570982;10565.101966332948;10565.577376904837;7551.962240188874;7833.412494062968;7836.568988705676;7922.801929951797;7927.286544210933;3012.758979281652;3065.739412149948;3072.4316001539787;3101.4882544380375;3133.6082989626298;894.3784070071368;935.7239614313658;974.5955428497236;975.2880397310004;1002.5438425516372;26978.86510567474;28204.15387538377;28303.29241768931;28627.427451451273;28698.569521457193;989.5547003848297;990.2078337330252;999.2805180270194;1001.244060734141;1016.8779746430475;14581.562553123424;14692.926535367254;14948.626284342761;15085.019473734172;15166.393344266326;329374;329505;333793;333840;334169;47771.522284777406;48225.27662085072;48301.275480867815;48349.75825120852;48367.274490882664;1058.4813441413653;1240.7146356338092;1258.9622311330859;1264.2856785916113;1279.0918447902093;24308.39229019218;25531.23406297814;26044.73955260423;26113.73886261113;26140.8692956534;37223.44164837584;38933.80533097316;39063.2187356257;39118.60881391264;39140.2171956565;228780;231319;231390;231467.16795488488;231572;22544.66183007289;24523.509529808947;25486.49027019412;25488.745112548637;25795.710214488827;35981.64018359783;36142.09644758902;36318.818405907805;36529.086772830895;36996.44505332368;31042.534361984137;31048.379032418772;31226;31673.683263167994;32234;31451.370972579964;31645;31672.20819479439;31848.840755796075;34207.48688769621;34079.82960085283;34433.13917152091;34535.82732086324;34569.48145777765;34993.65006349904;28596.142115736562;29828.254293641963;30151;30364.696353036186;30442.39115217639;24072.638910416706;24226;24263.393415164763;24401.145959891317;24598 06:27:15 INFO - PROCESS | 28833 | |2;jquery.html;381.4316668164435;381.477375994887;385.121218888806;386.1138686713993;393.95469521005094;15415.96906641155;16872.493825185247;17287.30850765968;17472.21375038123;17510;15688.450904218354;15835;16582.50252492427;16597.502074937773;16597.83402165978;5100.183970564701;5243.292155558989;5274.683518988873;5280;5284.101702710548;3703.1297645053523;5519.199716041172;6025.15647809307;6040.48655864252;6041.24484439445;5748.338941021794;5950.464458198761;5973.432523910222;5995.160677505153;5999.910001349983;5876.676782776945;5950.256217972754;5976;5978.910316345236;5980;3377.7635565510423;4945.480724523909;5297.417284098746;5307;5310.0441920454305;19793.16560195586;19873.30443434473;20492;21189.25837595692;21243.893780530998;1926.6435709393807;1974.9802501974941;2100.200798234962;2232.9451245544483;2404.5912194926905;12955.740885182244;13061.86938130616;13141.868581314257;13323.467061317535;13764.242966636832;1743.3810997096102;1815.482587462567;1815.754873092129;1828.8445482134034;1848.667239896818;58010;61487;64718.67640661766;68348.65825670889;72233.9164912532;15816.07402630517;16460.42388516396;16603.916980415263;16623.91688041552;16663.583410414838;30025.249368765955;30052.398952021274;30408.695913040585;30472.238194045327;30510.38979220403;8349.33205343571;8618.698345558001;8643.827123457495;8803.207711306013;8843;7052.858942821114;7074.823129421806;7181.784546463615;7184.6048467334795;7184.78445646621;8189.051941301127;8339.624716887754;8466.66133354659;8558.61486233121;8585.399022068521;2744.7529722325085;3364.4953257011152;3470.3926812808163;3512.416296732737;3558.2349794794245;840.1682334488934;867.4077014688319;872.9694460693845;891.9866202006975;896.1173244354305;16040.839591604168;16333.26500307489;16649.750253746202;17022.744658830128;17405.129743512774;824.8597738384489;871.324723339417;897.8776529338327;912.2428384440898;948.9193418559499;7179.517933802102;9194.448333099901;9491.335606507617;9521.857172142423;9533.285003624616;370339;382639;384207;393387;398503;78045;79214.60392698;79784;81577.59211203906;82322.17677823265;958.1759686669459;967.9080487353831;987.481572174614;990.4305024610877;1002.078088158881;14053.086549374259;14215.21816300072;14280.42878284857;14454.191081414463;14806.925965370536;33272.33455330928;33899.322013560086;34263.82868085644;34405.871295444704;34551.30897381988;46847.76576117097;48288.51711482981;48368.27447588219;48489.21151038787;48702.26946595733;7858.5677787722225;7905.169957154416;7953.443258972048;8149.674013039412;8154.673813047411;7365.447591430771;10967.177461690564;11372.829407558727;11595.420228988685;11638.592649257236;9842.950785246028;9940;10089.445080520642;10136.746581335525;10295.124914382062;9447.149756521945;9604.375715578464;9645.614175433186;9866.654667086617;10053.748656283651;7634;9294.209992150743;10008.949955250468;10205.132563732166;10580.841287380541;7688.730894418669;7741.467390223917;7911.643976021208;8110.391720621095;8129.349652027705;9612.18296444782;9723.319367644197;9748.317617766972;9890.901090989286;9923.603055877684 06:27:15 INFO - PROCESS | 28833 | |3;mootools.html;1226.32552096347;1434.3043623842434;1457.5627311806459;1588.1979600301845;1786.651602937427;7510.81222969426;7804.414668899827;7816.218378162181;7821.960890195548;7848.4113691473085;7542.245775422469;7681.462297639154;7693.076830780315;7697.422693297997;7714.074311082678;1882.2376937340398;1929.9324523641676;1933.4393026022437;2198.1317379635075;2232.653938639505;2237.5860465813876;2280.008196434548;2284.497410569672;2285.2915596165244;2285.874276914769;2226.3543572363997;2228.944276393095;2234.55308938213;2257.1874125314876;2260.028187879211;1814.9637007259912;2178.8256939444964;2223.7998580127705;2232.073689418897;2240.283109404983;2254.6246789458582;2284.8743319117443;2286.314105768263;2286.6684330771945;2287.5196208796174;7699.884501732478;7740.4194685398825;7752.418568607321;7761.922380776176;7762.340201082915;4527.660425468071;4718.457377401608;4729.314249433813;4738.265568836836;4744.644151688637;2916.4750344938116;2938.3388737534096;3038.969610303891;3069.6623371429123;3078.4766589679807;951.8477043673048;982.381099907054;991.9603215871357;998.965036223736;1009.238025290908;10656.09423199029;10677.41274229917;10681.626143085032;10683.091937185349;10692.198085143567;4235.97882010588;4241.554636763095;4395.956040439619;4435.046465009974;4438.622717069085;9226.169644732006;9228.492432916253;9234.122758337948;9240.630374785067;9284;4733.621310295168;4736.550027747358;4743.525647435229;4750.714957102516;4754.619630429557;3760.8871733848027;3925.684895559962;4220.986963128888;4276.615104640598;4278.336857787048;3680.6319368062977;3721.5348081489815;3786.6402691744242;3802.961970380316;3807.800542829;1237.3132911234172;1262.5517941130765;1268.3341245846004;1280.6286177008562;1283.6213317071486;752.8908308295375;821.3921697943598;863.9956800215958;880.3573391424168;919.2370332623906;5441.156620723794;5590.217369568264;5654.038813401731;5719.48524632785;5737;419.66846191508364;426.95730426957056;432.33420532379785;433.73542139295006;440.6474820143872;3826.6747326477002;3871.6128387161057;3876.5154355705536;3885.9028524286555;3916.8629097981434;9347.532623368805;9768.41389516617;9769.218462522982;9825.852612210823;9841.606335746634;9577.856332155023;9602.231821454267;9750.463724495221;9785.217182625373;9804;7126.714931402686;7134.750283740044;7171.713131474787;7218.6390680465765;7258.564486130849;5245.134552798745;5359.705216213146;5396;5490.725463726878;5515.7865269640615;8843.248323892283;8952;8997.37018408705;9037.864432033393;9070.501122438329;8799.340049496186;9001.054889236535;9127.041660625538;9157.633694652139;9202.217811486098;6085.847853803691;6479.870402592016;6632;6660.666966651745;6917.308269173243;7566.470347075872;7584.051993500812;7621.161672215941;7654;7665.923340766521;6839.89740153908;6970.581765094111;7022.508424410242;7091.219965803861;7102.360787529147;6853.965730171317;6882;6901.102856628606;6978.406835419046;6986.266442023514;6340.239171299474;6343.365663433804;6383.457406120346;6398.232212134573;6402.35976402356;4696.38946936896;4758.1435341638835;4776.641751868554;4778.904421911612;4806.663533552618;4760.904781904412;4771.76141192932;4813.181759101031;4855.902881942271;4862.489438608895 06:27:15 INFO - PROCESS | 28833 | |4;prototype.html;317.19907234233557;317.62678852348495;322.2700583179099;325.81754217638127;325.83382474937775;4968;4976.900461990758;4986.551210391064;5042.773075211615;5048.469910659383;5021.196608542634;5023.648344615878;5024.748762561866;5041.218611115274;5045.243213517974;3688.6311368863167;3801.505804245458;3931.1351502669368;3971.0270983609057;3984.6413822755944;3950.2494526040105;3966.960330396688;3971.3645816669336;3975.1254723960683;3977.8011099445057;3739.9252014959684;3944.3097457944746;3946.427767973642;3947.585503522132;3952.604739526039;3797.677197438221;3963.2667956427863;3964.6233607807358;3977.3238549446664;3985.3025720499086;3503.1067077894972;3515.1036485695986;3515.2442224921765;3523.5419395478425;3530.5939816921127;4767.880802979918;4780.450248221464;4784.162771515006;4786.2581299898575;4797.688150270256;4206.810693518799;4452.510223875371;4454.57681520255;4454.799534020977;4496.505384407713;5201.505856943584;5204.947950520522;5218.6868787872845;5227.085260079509;5236.633435659505;3730.7201959852846;3732;3735.383661695817;3735.477033215325;3736.346139425617;5186.896262074775;5442.156465747816;5500.80747173851;5516.503514683657;5523.861903452405;3791.5829258781514;3802.4676545283683;3806.8286927087793;3810.599887011879;3812.6187381262207;3853.7687738735203;3865.265599536079;3870.148567315186;3870.9806450967567;3875.6318149775725;4264.445622069174;4413.536578659258;4417.160739459557;4421.579949904753;4436.800343984464;5210.76551555181;5217.791288348423;5240.292560504359;5246.160614301693;5252.684838909678;1309.306067784076;1332.2273081612834;1336.832895888014;1337.1375462826422;1341.530464337474;830.7424698343533;894.3337213775778;902.8420026495469;906.9002409734924;915.2632131134368;4559.886002849956;4575.9084818303445;4579.656525760582;4621.2837010263465;4625.907481850344;5369.892602147936;5378.489043540857;5378.569714422837;5388.649737767033;5395.352557693023;4457.885528617846;4612.976935115303;4615.2769865779355;4629.189891768927;4631.722096674211;2851.615031970699;2859.156548818062;2873.2242294580346;2874.8131371460786;2883.1206482023185;5042.7982880685095;5074.340335756402;5087.618428617869;5106.080905436983;5117.181250999822;5251.897101608629;5448.427915068861;5460.453954604587;5461.596897365147;5472.015037293246;5042.445331013659;5068.442471328077;5077.390713114376;5078.847634570969;5080.415752188472;5307.893842123213;5321.494458026481;5322.600804939568;5329.813456529158;5340.652857564246;5041.924371134362;5219.19102539107;5314.707691077027;5315.521603055744;5328;5122.948770512247;5129.589632829439;5135;5148.819791307286;5174.353205849269;3791.1469919267943;3827.808609569566;3832.5400951885954;3834.1181528248103;3841.5966323535627;5178.689278643294;5391.919121213106;5394.460553944731;5410.404855465974;5449.945500544944;5212.713300768494;5246.3704355477585;5255.737213139251;5256.763445645031;5260.579153667621;5181.53366197029;5250.474952504719;5265.051211591306;5270.472952704698;5274.841754747364;5163.406208285945;5186.092433824141;5192.091384007859;5192.74036298176;5192.896142077062;5023.6985780853265;5076.466970967996;5226.947730522646;5273.841784746463;5287.154055351125;5127.5128862759475;5143.254228136974;5146.022255771391;5167;5193.610479213999 06:27:15 INFO - PROCESS | 28833 | |5;yui.html;686.0600976661974;699.2867275379114;710.119451879669;714.885618301072;714.9463790215732;10707.25049246552;10986.670399887997;10995.725106872333;11012.17408694347;11015.118790496761;11278.041366483858;11339.319640821557;11343.092552595794;11343.149263805206;11357.261777984426;635.8791829552371;786.4730630477566;801.3789313282194;815.355868863597;820.4543978254484;805.730080423056;805.9113497515268;811.3265989228926;811.4117264982899;811.9188081191893;856.5203486047833;858.5406807358065;858.5921687198593;860.0926023045685;860.389123722158;667.1893649216202;679.8742232686968;681.6319187638669;818.0592318833329;853.7950891785957;624.3413199074975;625.8310256230837;626.2703949898363;626.6991843914901;627.0468887291337;11850.585229517012;11866;11906.880931190664;11908;11936.104792140537;13076.803847942288;13321.66695832612;13526.256055916921;13670.384832682554;13689.931550342284;9296.816432605354;9459.479728614924;9621.470819105016;9631.518424078768;9826.508674566243;2938.911832645024;2942.1320710390487;3083.799553029068;3179.920501987469;3433.364827506919;45562.77218613919;46089;46252.53747462516;46279.30581041287;47171.99999999966;10051.346662466916;10101.343412678152;10147.238957078249;10151.847722284172;10356.792864142675;16911.49265522036;17059.829401705825;17077.48767536951;17137.828621713623;18200.089995500435;6119.785807496716;6121.173641558422;6140.293866205354;6194.876102477925;6242.500599951993;3407.454807230831;3410.84651190697;3429.0570093224565;3479.7216222702123;3486.8082255476193;2672.665916760405;2711.1188863619404;2754.4215714700135;2761.5995680626197;2763.668359796837;498.9875253118701;506.08903972848725;515.1088616693067;516.2024671881951;521.4707072321521;540.5837505121035;565.3667891960948;572.4275724275724;576.8903908257417;596.9731362088717;7199.964000179965;7251.673674684652;7389.556626602421;7501.849963000818;7684.961575192088;549.8158117030839;551.9944800551943;554.9056660367747;556.2462862820901;561.5591760468013;3412.692857642824;3555.9288814224087;3571.2857428514403;3632.9636703633155;3672.7429079964145;45967;46255.5374446258;47190.76404617955;47254;47721.5227847724;40660.59339406568;42238.15523689509;42551.57448425538;42699.35103127192;42857.57142428536;37467.06332341659;37837.62162378341;38154.9476041916;38688.80655596704;39219.21561568753;7994.2405471480115;8081.515109093473;8111.797205069921;8253.95873020631;8279.089300177096;28402.29586224833;28462.57306140451;28962.27594310159;29029.564556532092;29084.1274761749;33894;36444.63555364519;36836.81581592075;36966.63033369632;37468;9807.85288220663;10344.172466202835;10344.586216551254;10568.947155264175;10572.947135264274;11795.056395488169;11801.114916381477;11853.5851245206;11866.288022718665;11935.224210426295;9900.603975841173;9986.800263994533;10210.285280030326;10218.335808172445;10365.326253793479;10080.84878726805;10096.444695541815;10185.134263587677;10208.693739187836;10410.635627752992;10665.573377064831;10686.305390149615;10725.410102444128;10881.891181088087;11518.07855371585;9313.580888860153;9395.530223488935;9456.101670341306;9630.759231019281;9630.903690963001;9061.365704400629;9592.280578956466;9603.567839447102;9691.951540242253;9731.805363892825 06:27:15 INFO - PROCESS | 28833 | __end_tp_report 06:27:15 INFO - PROCESS | 28833 | __start_cc_report 06:27:15 INFO - PROCESS | 28833 | _x_x_mozilla_cycle_collect,1058 06:27:15 INFO - PROCESS | 28833 | __end_cc_report 06:27:15 INFO - PROCESS | 28833 | __startTimestamp1461331635430__endTimestamp 06:27:15 INFO - PROCESS | 28833 | 06:27:15 INFO - PROCESS | 28833 | ------- Summary: start ------- 06:27:15 INFO - PROCESS | 28833 | Number of tests: 6 06:27:15 INFO - PROCESS | 28833 | 06:27:15 INFO - PROCESS | 28833 | [#0] dojo.html Cycles:165 Average:4557.24 Median:4704.46 stddev:459.70 (9.8%) stddev-sans-first:433.67 06:27:15 INFO - PROCESS | 28833 | Values: 2562.9 2658.7 2672.9 2686.9 2688.6 4464.8 4561.9 4600.1 4615.6 4631.8 4582.5 4605.8 4613.4 4685.6 4700.7 4207.0 4225.9 4251.6 4292.0 4361.5 4293.7 4316.8 4329.9 4357.7 4370.3 4136.0 4210.6 4224.5 4246.8 4313.7 4213.5 4246.9 4247.3 4274.0 4293.5 4178.3 4201.5 4220.1 4226.0 4262.9 4388.6 4476.0 4513.2 4536.5 4573.0 4928.9 4931.5 4937.9 4941.8 4973.4 4949.7 4971.5 4974.7 4978.4 5029.3 4439.4 4590.2 4655.2 4695.1 4708.6 5018.3 5041.7 5045.8 5051.7 5071.6 4827.6 4836.2 4837.2 4845.1 4873.8 4719.5 4814.8 4887.0 4909.5 4914.1 4871.9 4873.1 4884.8 4901.4 4947.0 4848.4 4861.9 4876.2 4880.6 4934.0 4054.1 4121.4 4133.0 4226.9 4235.2 3663.2 3670.3 3670.4 3709.3 3723.2 4268.9 4272.0 4273.7 4306.5 4318.4 4733.6 4845.2 4920.2 4931.1 4948.1 4256.1 4272.2 4292.4 4312.0 4323.0 4409.6 4453.1 4455.1 4459.4 4498.7 4483.5 4655.1 4685.6 4726.5 4727.0 4954.5 4954.6 4975.4 4992.9 5007.7 4733.3 4735.3 4740.1 4756.4 4796.3 4670.5 4780.2 4841.8 4857.0 4857.2 4887.2 4903.9 4911.6 4920.9 4941.2 4764.0 4783.6 4790.7 4805.7 4840.7 4577.1 4698.6 4768.5 4792.8 4800.7 4697.8 4705.6 4723.5 4729.7 4779.8 4818.4 4820.7 4834.5 4835.4 4879.9 4555.0 4704.5 4788.6 4792.5 4804.0 06:27:15 INFO - PROCESS | 28833 | 06:27:15 INFO - PROCESS | 28833 | [#1] ext.html Cycles:180 Average:41287.49 Median:333816.50 stddev:69184.10 (20.7%) stddev-sans-first:69310.61 06:27:15 INFO - PROCESS | 28833 | Values: 563.8 596.7 601.3 612.3 613.7 26400.7 33958.8 35296.1 35348.1 35360.6 37687.4 38577.0 38609.0 38689.2 38733.0 7233.3 7582.1 7842.5 9444.5 9775.3 9637.3 9764.1 9770.2 9771.3 9774.7 9775.9 9859.3 9865.1 9866.4 9867.5 9771.3 9820.3 9829.6 9834.7 9839.7 9714.3 9815.5 9818.3 10055.8 10075.2 37207.6 37674.8 37699.8 37706.2 37735.4 3224.7 3316.4 3329.8 3410.9 3587.4 28170.0 28456.6 28572.9 28801.7 29787.6 3152.9 3165.9 3189.2 3212.3 3261.7 209380.0 212305.0 212753.0 212870.0 213890.0 53666.7 54325.5 54372.0 54453.5 54558.7 57142.4 57236.1 57292.0 57467.7 57506.1 12467.3 12925.6 12942.5 12943.2 12947.9 10497.7 10527.8 10549.3 10565.1 10565.6 7552.0 7833.4 7836.6 7922.8 7927.3 3012.8 3065.7 3072.4 3101.5 3133.6 894.4 935.7 974.6 975.3 1002.5 26978.9 28204.2 28303.3 28627.4 28698.6 989.6 990.2 999.3 1001.2 1016.9 14581.6 14692.9 14948.6 15085.0 15166.4 329374.0 329505.0 333793.0 333840.0 334169.0 47771.5 48225.3 48301.3 48349.8 48367.3 1058.5 1240.7 1259.0 1264.3 1279.1 24308.4 25531.2 26044.7 26113.7 26140.9 37223.4 38933.8 39063.2 39118.6 39140.2 228780.0 231319.0 231390.0 231467.2 231572.0 22544.7 24523.5 25486.5 25488.7 25795.7 35981.6 36142.1 36318.8 36529.1 36996.4 31042.5 31048.4 31226.0 31673.7 32234.0 31451.4 31645.0 31672.2 31848.8 34207.5 34079.8 34433.1 34535.8 34569.5 34993.7 28596.1 29828.3 30151.0 30364.7 30442.4 24072.6 24226.0 24263.4 24401.1 24598.0 06:27:15 INFO - PROCESS | 28833 | 06:27:15 INFO - PROCESS | 28833 | [#2] jquery.html Cycles:180 Average:24848.68 Median:5171.74 stddev:63592.41 (1229.6%) stddev-sans-first:63744.27 06:27:15 INFO - PROCESS | 28833 | Values: 381.4 381.5 385.1 386.1 394.0 15416.0 16872.5 17287.3 17472.2 17510.0 15688.5 15835.0 16582.5 16597.5 16597.8 5100.2 5243.3 5274.7 5280.0 5284.1 3703.1 5519.2 6025.2 6040.5 6041.2 5748.3 5950.5 5973.4 5995.2 5999.9 5876.7 5950.3 5976.0 5978.9 5980.0 3377.8 4945.5 5297.4 5307.0 5310.0 19793.2 19873.3 20492.0 21189.3 21243.9 1926.6 1975.0 2100.2 2232.9 2404.6 12955.7 13061.9 13141.9 13323.5 13764.2 1743.4 1815.5 1815.8 1828.8 1848.7 58010.0 61487.0 64718.7 68348.7 72233.9 15816.1 16460.4 16603.9 16623.9 16663.6 30025.2 30052.4 30408.7 30472.2 30510.4 8349.3 8618.7 8643.8 8803.2 8843.0 7052.9 7074.8 7181.8 7184.6 7184.8 8189.1 8339.6 8466.7 8558.6 8585.4 2744.8 3364.5 3470.4 3512.4 3558.2 840.2 867.4 873.0 892.0 896.1 16040.8 16333.3 16649.8 17022.7 17405.1 824.9 871.3 897.9 912.2 948.9 7179.5 9194.4 9491.3 9521.9 9533.3 370339.0 382639.0 384207.0 393387.0 398503.0 78045.0 79214.6 79784.0 81577.6 82322.2 958.2 967.9 987.5 990.4 1002.1 14053.1 14215.2 14280.4 14454.2 14806.9 33272.3 33899.3 34263.8 34405.9 34551.3 46847.8 48288.5 48368.3 48489.2 48702.3 7858.6 7905.2 7953.4 8149.7 8154.7 7365.4 10967.2 11372.8 11595.4 11638.6 9843.0 9940.0 10089.4 10136.7 10295.1 9447.1 9604.4 9645.6 9866.7 10053.7 7634.0 9294.2 10008.9 10205.1 10580.8 7688.7 7741.5 7911.6 8110.4 8129.3 9612.2 9723.3 9748.3 9890.9 9923.6 06:27:15 INFO - PROCESS | 28833 | 06:27:15 INFO - PROCESS | 28833 | [#3] mootools.html Cycles:180 Average:5203.44 Median:5053.81 stddev:2896.16 (57.3%) stddev-sans-first:2888.86 06:27:15 INFO - PROCESS | 28833 | Values: 1226.3 1434.3 1457.6 1588.2 1786.7 7510.8 7804.4 7816.2 7822.0 7848.4 7542.2 7681.5 7693.1 7697.4 7714.1 1882.2 1929.9 1933.4 2198.1 2232.7 2237.6 2280.0 2284.5 2285.3 2285.9 2226.4 2228.9 2234.6 2257.2 2260.0 1815.0 2178.8 2223.8 2232.1 2240.3 2254.6 2284.9 2286.3 2286.7 2287.5 7699.9 7740.4 7752.4 7761.9 7762.3 4527.7 4718.5 4729.3 4738.3 4744.6 2916.5 2938.3 3039.0 3069.7 3078.5 951.8 982.4 992.0 999.0 1009.2 10656.1 10677.4 10681.6 10683.1 10692.2 4236.0 4241.6 4396.0 4435.0 4438.6 9226.2 9228.5 9234.1 9240.6 9284.0 4733.6 4736.6 4743.5 4750.7 4754.6 3760.9 3925.7 4221.0 4276.6 4278.3 3680.6 3721.5 3786.6 3803.0 3807.8 1237.3 1262.6 1268.3 1280.6 1283.6 752.9 821.4 864.0 880.4 919.2 5441.2 5590.2 5654.0 5719.5 5737.0 419.7 427.0 432.3 433.7 440.6 3826.7 3871.6 3876.5 3885.9 3916.9 9347.5 9768.4 9769.2 9825.9 9841.6 9577.9 9602.2 9750.5 9785.2 9804.0 7126.7 7134.8 7171.7 7218.6 7258.6 5245.1 5359.7 5396.0 5490.7 5515.8 8843.2 8952.0 8997.4 9037.9 9070.5 8799.3 9001.1 9127.0 9157.6 9202.2 6085.8 6479.9 6632.0 6660.7 6917.3 7566.5 7584.1 7621.2 7654.0 7665.9 6839.9 6970.6 7022.5 7091.2 7102.4 6854.0 6882.0 6901.1 6978.4 6986.3 6340.2 6343.4 6383.5 6398.2 6402.4 4696.4 4758.1 4776.6 4778.9 4806.7 4760.9 4771.8 4813.2 4855.9 4862.5 06:27:15 INFO - PROCESS | 28833 | 06:27:15 INFO - PROCESS | 28833 | [#4] prototype.html Cycles:180 Average:4349.54 Median:5024.22 stddev:1255.77 (25.0%) stddev-sans-first:1222.28 06:27:15 INFO - PROCESS | 28833 | Values: 317.2 317.6 322.3 325.8 325.8 4968.0 4976.9 4986.6 5042.8 5048.5 5021.2 5023.6 5024.7 5041.2 5045.2 3688.6 3801.5 3931.1 3971.0 3984.6 3950.2 3967.0 3971.4 3975.1 3977.8 3739.9 3944.3 3946.4 3947.6 3952.6 3797.7 3963.3 3964.6 3977.3 3985.3 3503.1 3515.1 3515.2 3523.5 3530.6 4767.9 4780.5 4784.2 4786.3 4797.7 4206.8 4452.5 4454.6 4454.8 4496.5 5201.5 5204.9 5218.7 5227.1 5236.6 3730.7 3732.0 3735.4 3735.5 3736.3 5186.9 5442.2 5500.8 5516.5 5523.9 3791.6 3802.5 3806.8 3810.6 3812.6 3853.8 3865.3 3870.1 3871.0 3875.6 4264.4 4413.5 4417.2 4421.6 4436.8 5210.8 5217.8 5240.3 5246.2 5252.7 1309.3 1332.2 1336.8 1337.1 1341.5 830.7 894.3 902.8 906.9 915.3 4559.9 4575.9 4579.7 4621.3 4625.9 5369.9 5378.5 5378.6 5388.6 5395.4 4457.9 4613.0 4615.3 4629.2 4631.7 2851.6 2859.2 2873.2 2874.8 2883.1 5042.8 5074.3 5087.6 5106.1 5117.2 5251.9 5448.4 5460.5 5461.6 5472.0 5042.4 5068.4 5077.4 5078.8 5080.4 5307.9 5321.5 5322.6 5329.8 5340.7 5041.9 5219.2 5314.7 5315.5 5328.0 5122.9 5129.6 5135.0 5148.8 5174.4 3791.1 3827.8 3832.5 3834.1 3841.6 5178.7 5391.9 5394.5 5410.4 5449.9 5212.7 5246.4 5255.7 5256.8 5260.6 5181.5 5250.5 5265.1 5270.5 5274.8 5163.4 5186.1 5192.1 5192.7 5192.9 5023.7 5076.5 5226.9 5273.8 5287.2 5127.5 5143.3 5146.0 5167.0 5193.6 06:27:15 INFO - PROCESS | 28833 | 06:27:15 INFO - PROCESS | 28833 | [#5] yui.html Cycles:180 Average:12125.44 Median:42778.46 stddev:13439.58 (31.4%) stddev-sans-first:13449.83 06:27:15 INFO - PROCESS | 28833 | Values: 686.1 699.3 710.1 714.9 714.9 10707.3 10986.7 10995.7 11012.2 11015.1 11278.0 11339.3 11343.1 11343.1 11357.3 635.9 786.5 801.4 815.4 820.5 805.7 805.9 811.3 811.4 811.9 856.5 858.5 858.6 860.1 860.4 667.2 679.9 681.6 818.1 853.8 624.3 625.8 626.3 626.7 627.0 11850.6 11866.0 11906.9 11908.0 11936.1 13076.8 13321.7 13526.3 13670.4 13689.9 9296.8 9459.5 9621.5 9631.5 9826.5 2938.9 2942.1 3083.8 3179.9 3433.4 45562.8 46089.0 46252.5 46279.3 47172.0 10051.3 10101.3 10147.2 10151.8 10356.8 16911.5 17059.8 17077.5 17137.8 18200.1 6119.8 6121.2 6140.3 6194.9 6242.5 3407.5 3410.8 3429.1 3479.7 3486.8 2672.7 2711.1 2754.4 2761.6 2763.7 499.0 506.1 515.1 516.2 521.5 540.6 565.4 572.4 576.9 597.0 7200.0 7251.7 7389.6 7501.8 7685.0 549.8 552.0 554.9 556.2 561.6 3412.7 3555.9 3571.3 3633.0 3672.7 45967.0 46255.5 47190.8 47254.0 47721.5 40660.6 42238.2 42551.6 42699.4 42857.6 37467.1 37837.6 38154.9 38688.8 39219.2 7994.2 8081.5 8111.8 8254.0 8279.1 28402.3 28462.6 28962.3 29029.6 29084.1 33894.0 36444.6 36836.8 36966.6 37468.0 9807.9 10344.2 10344.6 10568.9 10572.9 11795.1 11801.1 11853.6 11866.3 11935.2 9900.6 9986.8 10210.3 10218.3 10365.3 10080.8 10096.4 10185.1 10208.7 10410.6 10665.6 10686.3 10725.4 10881.9 11518.1 9313.6 9395.5 9456.1 9630.8 9630.9 9061.4 9592.3 9603.6 9692.0 9731.8 06:27:15 INFO - PROCESS | 28833 | -------- Summary: end -------- 06:27:15 INFO - PROCESS | 28833 | 06:27:16 INFO - TEST-INFO | 28833: exit 0 06:27:16 INFO - TEST-OK | dromaeo_css | took 1118835ms 06:27:16 INFO - TEST-START | kraken 06:27:16 INFO - operating with platform_type : linux_ 06:27:16 INFO - Initialising browser for kraken test... 06:27:16 INFO - TEST-INFO | started process 29020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVf7fIq/profile http://localhost:60417/getInfo.html) 06:27:20 INFO - PROCESS | 29020 | __metrics Screen width/height:1600/1200 06:27:20 INFO - PROCESS | 29020 | colorDepth:24 06:27:20 INFO - PROCESS | 29020 | Browser inner width/height: 1024/697 06:27:20 INFO - PROCESS | 29020 | __metrics 06:27:21 ERROR - PROCESS | 29020 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:27:22 INFO - TEST-INFO | 29020: exit 0 06:27:22 INFO - Browser initialized. 06:27:22 INFO - Running cycle 1/1 for kraken test... 06:27:22 INFO - TEST-INFO | started process 29102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVf7fIq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:27:34 INFO - PROCESS | 29102 | RSS: Main: 155189248 06:27:34 INFO - PROCESS | 29102 | 06:27:37 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60417/tests/kraken/driver.html?testName=audio-beat-detection) 06:27:38 INFO - PROCESS | 29102 | RSS: Main: 210259968 06:27:38 INFO - PROCESS | 29102 | 06:27:40 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60417/tests/kraken/driver.html?testName=audio-dft) 06:27:41 INFO - PROCESS | 29102 | RSS: Main: 195006464 06:27:41 INFO - PROCESS | 29102 | 06:27:44 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60417/tests/kraken/driver.html?testName=audio-fft) 06:27:45 INFO - PROCESS | 29102 | RSS: Main: 266911744 06:27:45 INFO - PROCESS | 29102 | 06:27:47 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60417/tests/kraken/driver.html?testName=audio-oscillator) 06:27:48 INFO - PROCESS | 29102 | RSS: Main: 175046656 06:27:48 INFO - PROCESS | 29102 | 06:27:50 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60417/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:27:50 INFO - PROCESS | 29102 | RSS: Main: 178606080 06:27:50 INFO - PROCESS | 29102 | 06:27:54 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60417/tests/kraken/driver.html?testName=imaging-darkroom) 06:27:54 INFO - PROCESS | 29102 | RSS: Main: 214732800 06:27:54 INFO - PROCESS | 29102 | 06:27:58 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60417/tests/kraken/driver.html?testName=imaging-desaturate) 06:27:58 INFO - PROCESS | 29102 | RSS: Main: 215531520 06:27:58 INFO - PROCESS | 29102 | 06:28:01 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60417/tests/kraken/driver.html?testName=json-parse-financial) 06:28:02 INFO - PROCESS | 29102 | RSS: Main: 216186880 06:28:02 INFO - PROCESS | 29102 | 06:28:03 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60417/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:28:04 INFO - PROCESS | 29102 | RSS: Main: 201764864 06:28:04 INFO - PROCESS | 29102 | 06:28:06 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60417/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:28:06 INFO - PROCESS | 29102 | RSS: Main: 207065088 06:28:06 INFO - PROCESS | 29102 | 06:28:09 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60417/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:28:09 INFO - PROCESS | 29102 | RSS: Main: 219054080 06:28:09 INFO - PROCESS | 29102 | 06:28:12 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:28:13 INFO - PROCESS | 29102 | RSS: Main: 225570816 06:28:13 INFO - PROCESS | 29102 | 06:28:16 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:28:16 INFO - PROCESS | 29102 | RSS: Main: 218710016 06:28:16 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | Cycle 1(1): loaded http://localhost:60417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60417/tests/kraken/driver.html?testName=ai-astar) 06:28:18 INFO - PROCESS | 29102 | RSS: Main: 282296320 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | __start_tp_report 06:28:18 INFO - PROCESS | 29102 | _x_x_mozilla_page_load 06:28:18 INFO - PROCESS | 29102 | _x_x_mozilla_page_load_details 06:28:18 INFO - PROCESS | 29102 | |i|pagename|runs| 06:28:18 INFO - PROCESS | 29102 | |0;ai-astar;110;114;107;111;116;114;103;112;112;113 06:28:18 INFO - PROCESS | 29102 | |1;audio-beat-detection;158;139;163;190;134;174;155;139;183;136 06:28:18 INFO - PROCESS | 29102 | |2;audio-dft;161;162;164;163;162;162;162;162;161;161 06:28:18 INFO - PROCESS | 29102 | |3;audio-fft;78;75;110;107;75;74;74;108;104;73 06:28:18 INFO - PROCESS | 29102 | |4;audio-oscillator;94;96;154;94;95;95;142;94;93;147 06:28:18 INFO - PROCESS | 29102 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 06:28:18 INFO - PROCESS | 29102 | |6;imaging-darkroom;145;146;146;146;145;146;146;146;146;146 06:28:18 INFO - PROCESS | 29102 | |7;imaging-desaturate;95;95;95;94;94;95;95;95;94;94 06:28:18 INFO - PROCESS | 29102 | |8;json-parse-financial;65;65;64;65;65;65;66;90;63;62 06:28:18 INFO - PROCESS | 29102 | |9;json-stringify-tinderbox;66;64;64;64;65;64;65;65;64;65 06:28:18 INFO - PROCESS | 29102 | |10;stanford-crypto-aes;80;80;80;77;88;79;79;78;79;80 06:28:18 INFO - PROCESS | 29102 | |11;stanford-crypto-ccm;136;140;133;131;131;133;131;133;172;136 06:28:18 INFO - PROCESS | 29102 | |12;stanford-crypto-pbkdf2;172;171;173;170;170;172;169;171;175;172 06:28:18 INFO - PROCESS | 29102 | |13;stanford-crypto-sha256-iterative;75;72;72;72;72;72;72;72;71;71 06:28:18 INFO - PROCESS | 29102 | __end_tp_report 06:28:18 INFO - PROCESS | 29102 | __start_cc_report 06:28:18 INFO - PROCESS | 29102 | _x_x_mozilla_cycle_collect,1880 06:28:18 INFO - PROCESS | 29102 | __end_cc_report 06:28:18 INFO - PROCESS | 29102 | __startTimestamp1461331698650__endTimestamp 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | ------- Summary: start ------- 06:28:18 INFO - PROCESS | 29102 | Number of tests: 14 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:3.79 (3.4%) stddev-sans-first:4.00 06:28:18 INFO - PROCESS | 29102 | Values: 110.0 114.0 107.0 111.0 116.0 114.0 103.0 112.0 112.0 113.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#1] audio-beat-detection Cycles:10 Average:157.10 Median:160.50 stddev:20.31 (12.7%) stddev-sans-first:21.54 06:28:18 INFO - PROCESS | 29102 | Values: 158.0 139.0 163.0 190.0 134.0 174.0 155.0 139.0 183.0 136.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 06:28:18 INFO - PROCESS | 29102 | Values: 161.0 162.0 164.0 163.0 162.0 162.0 162.0 162.0 161.0 161.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#3] audio-fft Cycles:10 Average:87.80 Median:74.00 stddev:16.85 (22.8%) stddev-sans-first:17.50 06:28:18 INFO - PROCESS | 29102 | Values: 78.0 75.0 110.0 107.0 75.0 74.0 74.0 108.0 104.0 73.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:94.00 stddev:25.89 (27.5%) stddev-sans-first:26.77 06:28:18 INFO - PROCESS | 29102 | Values: 94.0 96.0 154.0 94.0 95.0 95.0 142.0 94.0 93.0 147.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:28:18 INFO - PROCESS | 29102 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 06:28:18 INFO - PROCESS | 29102 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:28:18 INFO - PROCESS | 29102 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:65.00 stddev:8.16 (12.6%) stddev-sans-first:8.63 06:28:18 INFO - PROCESS | 29102 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 66.0 90.0 63.0 62.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 06:28:18 INFO - PROCESS | 29102 | Values: 66.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:2.98 (3.7%) stddev-sans-first:3.16 06:28:18 INFO - PROCESS | 29102 | Values: 80.0 80.0 80.0 77.0 88.0 79.0 79.0 78.0 79.0 80.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:134.50 stddev:12.42 (9.2%) stddev-sans-first:13.16 06:28:18 INFO - PROCESS | 29102 | Values: 136.0 140.0 133.0 131.0 131.0 133.0 131.0 133.0 172.0 136.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.00 stddev:1.72 (1.0%) stddev-sans-first:1.81 06:28:18 INFO - PROCESS | 29102 | Values: 172.0 171.0 173.0 170.0 170.0 172.0 169.0 171.0 175.0 172.0 06:28:18 INFO - PROCESS | 29102 | 06:28:18 INFO - PROCESS | 29102 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:1.10 (1.5%) stddev-sans-first:0.44 06:28:18 INFO - PROCESS | 29102 | Values: 75.0 72.0 72.0 72.0 72.0 72.0 72.0 72.0 71.0 71.0 06:28:18 INFO - PROCESS | 29102 | -------- Summary: end -------- 06:28:18 INFO - PROCESS | 29102 | 06:28:19 INFO - TEST-INFO | 29102: exit 0 06:28:19 INFO - TEST-OK | kraken | took 63457ms 06:28:19 INFO - SUITE-END | took 1182s 06:28:19 INFO - Completed test suite (00:19:42) 06:28:19 INFO - javascript benchmark 06:28:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2562.923112306631, 2658.7341265873415, 2672.9064482743097, 2686.9059582914597, 2688.5832695932113, 4464.799084041218, 4561.863144105674, 4600.079984003196, 4615.630749540037, 4631.7915693793775, 4582.495925448198, 4605.769711514427, 4613.423322084739, 4685.578297953183, 4700.670953033289, 4206.978965105171, 4225.8732238032835, 4251.638610718092, 4291.9570804292025, 4361.476622805268, 4293.742375457467, 4316.784160791948, 4329.935050974238, 4357.651387888977, 4370.3007518797, 4136.0, 4210.578942105795, 4224.493060832689, 4246.80889359978, 4313.741175529478, 4213.47331583552, 4246.893827654333, 4247.27796274631, 4273.957260427387, 4293.48478182617, 4178.331466965301, 4201.537830838605, 4220.07158425146, 4225.9788701056605, 4262.893427664302, 4388.561143885618, 4475.955240447586, 4513.232750432434, 4536.478304994935, 4573.039661671053, 4928.926066109011, 4931.506849315076, 4937.851864444073, 4941.777620007108, 4973.403191616993, 4949.727764972925, 4971.527704868032, 4974.676646017997, 4978.427480839714, 5029.2958985742025, 4439.400680908101, 4590.150822097922, 4655.162070827249, 4695.131400690815, 4708.599769019672, 5018.272350509229, 5041.697498150123, 5045.823396181189, 5051.747412629354, 5071.568916642127, 4827.589654879304, 4836.202026665561, 4837.22604383304, 4845.127876982177, 4873.780679869415, 4719.480857105716, 4814.807407703723, 4887.0, 4909.533594308535, 4914.140025495524, 4871.853844384674, 4873.074115917964, 4884.780184891689, 4901.362822833009, 4947.0, 4848.442429120626, 4861.878453038632, 4876.171050921281, 4880.585150262196, 4934.037862616827, 4054.1486287879284, 4121.361189015707, 4133.028738246509, 4226.894327641833, 4235.195312890541, 3663.2307215484516, 3670.302642497917, 3670.4127339625534, 3709.27669104522, 3723.2181241938956, 4268.871933841928, 4271.957280427218, 4273.743575385487, 4306.461692288464, 4318.373835793793, 4733.5503127202865, 4845.200541910545, 4920.21276595743, 4931.087748766489, 4948.05986862495, 4256.127493863751, 4272.230998420314, 4292.356146577976, 4312.029793296546, 4323.005708687019, 4409.581089796464, 4453.087117140978, 4455.064436468378, 4459.44256967879, 4498.730076195438, 4483.461984561874, 4655.092257009851, 4685.6017238535105, 4726.503717109654, 4726.976365118152, 4954.479779623088, 4954.554090131761, 4975.353204083446, 4992.900141997067, 5007.69953802773, 4733.3373327734835, 4735.266033764772, 4740.099381117715, 4756.357891684578, 4796.2805579163405, 4670.462896766915, 4780.235162374003, 4841.782119804547, 4856.975715121402, 4857.222844344888, 4887.242477416006, 4903.934308606, 4911.607071434348, 4920.92618610714, 4941.209406494943, 4764.0, 4783.593394561502, 4790.664653474363, 4805.735684537384, 4840.7337596432535, 4577.1074640444795, 4698.624110071254, 4768.523147685204, 4792.808287668454, 4800.711957282574, 4697.8355757548325, 4705.6000239979985, 4723.480417154179, 4729.692569983078, 4779.808807647655, 4818.445878723992, 4820.68665536753, 4834.516548345137, 4835.3714017178945, 4879.853604391874, 4554.954450455453, 4704.458987216514, 4788.592969597484, 4792.520747925179, 4803.975980120077], "value": 4529.3940314533875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7773079633545, 596.6777939912445, 601.3024891126294, 612.2775125352083, 613.7422282641292, 26400.735992640068, 33958.830205848964, 35296.11759706009, 35348.11629709259, 35360.64639353609, 37687.434688479625, 38577.0, 38609.0, 38689.226215475675, 38732.99999999993, 7233.276672332777, 7582.090149182106, 7842.451028427984, 9444.48055356955, 9775.31572789905, 9637.277204209677, 9764.12122908938, 9770.218382529416, 9771.267154963407, 9774.706758797247, 9775.902240977606, 9859.260555458333, 9865.112139907407, 9866.408015519057, 9867.506624668773, 9771.316007879452, 9820.263480238938, 9829.557669904836, 9834.655787047419, 9839.704808855746, 9714.31999760017, 9815.509224538744, 9818.26363022776, 10055.849162262572, 10075.244356673278, 37207.62792372068, 37674.81162594169, 37699.81150094232, 37706.24587508262, 37735.43396849049, 3224.7258982986473, 3316.3533111043357, 3329.783564068328, 3410.9147271318166, 3587.443946188348, 28170.0, 28456.573151402747, 28572.857135714396, 28801.71198288011, 29787.55318670222, 3152.921176970571, 3165.9208519786957, 3189.202699325169, 3212.3093534889877, 3261.6901394367733, 209380.0, 212305.0, 212753.0, 212870.0, 213890.0, 53666.73166634142, 54325.45674543283, 54372.0, 54453.45546544563, 54558.727206363714, 57142.42857571454, 57236.14145787816, 57292.0, 57467.712661436424, 57506.13740793891, 12467.314297713712, 12925.612231633066, 12942.547010854574, 12943.158694684815, 12947.935260323826, 10497.737556561147, 10527.84208236877, 10549.314294570982, 10565.101966332948, 10565.577376904837, 7551.962240188874, 7833.412494062968, 7836.568988705676, 7922.801929951797, 7927.286544210933, 3012.758979281652, 3065.739412149948, 3072.4316001539787, 3101.4882544380375, 3133.6082989626298, 894.3784070071368, 935.7239614313658, 974.5955428497236, 975.2880397310004, 1002.5438425516372, 26978.86510567474, 28204.15387538377, 28303.29241768931, 28627.427451451273, 28698.569521457193, 989.5547003848297, 990.2078337330252, 999.2805180270194, 1001.244060734141, 1016.8779746430475, 14581.562553123424, 14692.926535367254, 14948.626284342761, 15085.019473734172, 15166.393344266326, 329374.0, 329505.0, 333793.0, 333840.0, 334169.0, 47771.522284777406, 48225.27662085072, 48301.275480867815, 48349.75825120852, 48367.274490882664, 1058.4813441413653, 1240.7146356338092, 1258.9622311330859, 1264.2856785916113, 1279.0918447902093, 24308.39229019218, 25531.23406297814, 26044.73955260423, 26113.73886261113, 26140.8692956534, 37223.44164837584, 38933.80533097316, 39063.2187356257, 39118.60881391264, 39140.2171956565, 228780.0, 231319.0, 231390.0, 231467.16795488488, 231572.0, 22544.66183007289, 24523.509529808947, 25486.49027019412, 25488.745112548637, 25795.710214488827, 35981.64018359783, 36142.09644758902, 36318.818405907805, 36529.086772830895, 36996.44505332368, 31042.534361984137, 31048.379032418772, 31226.0, 31673.683263167994, 32234.0, 31451.370972579964, 31645.0, 31672.20819479439, 31848.840755796075, 34207.48688769621, 34079.82960085283, 34433.13917152091, 34535.82732086324, 34569.48145777765, 34993.65006349904, 28596.142115736562, 29828.254293641963, 30151.0, 30364.696353036186, 30442.39115217639, 24072.638910416706, 24226.0, 24263.393415164763, 24401.145959891317, 24598.0], "value": 16458.711528959142, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.4316668164435, 381.477375994887, 385.121218888806, 386.1138686713993, 393.95469521005094, 15415.96906641155, 16872.493825185247, 17287.30850765968, 17472.21375038123, 17510.0, 15688.450904218354, 15835.0, 16582.50252492427, 16597.502074937773, 16597.83402165978, 5100.183970564701, 5243.292155558989, 5274.683518988873, 5280.0, 5284.101702710548, 3703.1297645053523, 5519.199716041172, 6025.15647809307, 6040.48655864252, 6041.24484439445, 5748.338941021794, 5950.464458198761, 5973.432523910222, 5995.160677505153, 5999.910001349983, 5876.676782776945, 5950.256217972754, 5976.0, 5978.910316345236, 5980.0, 3377.7635565510423, 4945.480724523909, 5297.417284098746, 5307.0, 5310.0441920454305, 19793.16560195586, 19873.30443434473, 20492.0, 21189.25837595692, 21243.893780530998, 1926.6435709393807, 1974.9802501974941, 2100.200798234962, 2232.9451245544483, 2404.5912194926905, 12955.740885182244, 13061.86938130616, 13141.868581314257, 13323.467061317535, 13764.242966636832, 1743.3810997096102, 1815.482587462567, 1815.754873092129, 1828.8445482134034, 1848.667239896818, 58010.0, 61487.0, 64718.67640661766, 68348.65825670889, 72233.9164912532, 15816.07402630517, 16460.42388516396, 16603.916980415263, 16623.91688041552, 16663.583410414838, 30025.249368765955, 30052.398952021274, 30408.695913040585, 30472.238194045327, 30510.38979220403, 8349.33205343571, 8618.698345558001, 8643.827123457495, 8803.207711306013, 8843.0, 7052.858942821114, 7074.823129421806, 7181.784546463615, 7184.6048467334795, 7184.78445646621, 8189.051941301127, 8339.624716887754, 8466.66133354659, 8558.61486233121, 8585.399022068521, 2744.7529722325085, 3364.4953257011152, 3470.3926812808163, 3512.416296732737, 3558.2349794794245, 840.1682334488934, 867.4077014688319, 872.9694460693845, 891.9866202006975, 896.1173244354305, 16040.839591604168, 16333.26500307489, 16649.750253746202, 17022.744658830128, 17405.129743512774, 824.8597738384489, 871.324723339417, 897.8776529338327, 912.2428384440898, 948.9193418559499, 7179.517933802102, 9194.448333099901, 9491.335606507617, 9521.857172142423, 9533.285003624616, 370339.0, 382639.0, 384207.0, 393387.0, 398503.0, 78045.0, 79214.60392698, 79784.0, 81577.59211203906, 82322.17677823265, 958.1759686669459, 967.9080487353831, 987.481572174614, 990.4305024610877, 1002.078088158881, 14053.086549374259, 14215.21816300072, 14280.42878284857, 14454.191081414463, 14806.925965370536, 33272.33455330928, 33899.322013560086, 34263.82868085644, 34405.871295444704, 34551.30897381988, 46847.76576117097, 48288.51711482981, 48368.27447588219, 48489.21151038787, 48702.26946595733, 7858.5677787722225, 7905.169957154416, 7953.443258972048, 8149.674013039412, 8154.673813047411, 7365.447591430771, 10967.177461690564, 11372.829407558727, 11595.420228988685, 11638.592649257236, 9842.950785246028, 9940.0, 10089.445080520642, 10136.746581335525, 10295.124914382062, 9447.149756521945, 9604.375715578464, 9645.614175433186, 9866.654667086617, 10053.748656283651, 7634.0, 9294.209992150743, 10008.949955250468, 10205.132563732166, 10580.841287380541, 7688.730894418669, 7741.467390223917, 7911.643976021208, 8110.391720621095, 8129.349652027705, 9612.18296444782, 9723.319367644197, 9748.317617766972, 9890.901090989286, 9923.603055877684], "value": 8910.00002805325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.32552096347, 1434.3043623842434, 1457.5627311806459, 1588.1979600301845, 1786.651602937427, 7510.81222969426, 7804.414668899827, 7816.218378162181, 7821.960890195548, 7848.4113691473085, 7542.245775422469, 7681.462297639154, 7693.076830780315, 7697.422693297997, 7714.074311082678, 1882.2376937340398, 1929.9324523641676, 1933.4393026022437, 2198.1317379635075, 2232.653938639505, 2237.5860465813876, 2280.008196434548, 2284.497410569672, 2285.2915596165244, 2285.874276914769, 2226.3543572363997, 2228.944276393095, 2234.55308938213, 2257.1874125314876, 2260.028187879211, 1814.9637007259912, 2178.8256939444964, 2223.7998580127705, 2232.073689418897, 2240.283109404983, 2254.6246789458582, 2284.8743319117443, 2286.314105768263, 2286.6684330771945, 2287.5196208796174, 7699.884501732478, 7740.4194685398825, 7752.418568607321, 7761.922380776176, 7762.340201082915, 4527.660425468071, 4718.457377401608, 4729.314249433813, 4738.265568836836, 4744.644151688637, 2916.4750344938116, 2938.3388737534096, 3038.969610303891, 3069.6623371429123, 3078.4766589679807, 951.8477043673048, 982.381099907054, 991.9603215871357, 998.965036223736, 1009.238025290908, 10656.09423199029, 10677.41274229917, 10681.626143085032, 10683.091937185349, 10692.198085143567, 4235.97882010588, 4241.554636763095, 4395.956040439619, 4435.046465009974, 4438.622717069085, 9226.169644732006, 9228.492432916253, 9234.122758337948, 9240.630374785067, 9284.0, 4733.621310295168, 4736.550027747358, 4743.525647435229, 4750.714957102516, 4754.619630429557, 3760.8871733848027, 3925.684895559962, 4220.986963128888, 4276.615104640598, 4278.336857787048, 3680.6319368062977, 3721.5348081489815, 3786.6402691744242, 3802.961970380316, 3807.800542829, 1237.3132911234172, 1262.5517941130765, 1268.3341245846004, 1280.6286177008562, 1283.6213317071486, 752.8908308295375, 821.3921697943598, 863.9956800215958, 880.3573391424168, 919.2370332623906, 5441.156620723794, 5590.217369568264, 5654.038813401731, 5719.48524632785, 5737.0, 419.66846191508364, 426.95730426957056, 432.33420532379785, 433.73542139295006, 440.6474820143872, 3826.6747326477002, 3871.6128387161057, 3876.5154355705536, 3885.9028524286555, 3916.8629097981434, 9347.532623368805, 9768.41389516617, 9769.218462522982, 9825.852612210823, 9841.606335746634, 9577.856332155023, 9602.231821454267, 9750.463724495221, 9785.217182625373, 9804.0, 7126.714931402686, 7134.750283740044, 7171.713131474787, 7218.6390680465765, 7258.564486130849, 5245.134552798745, 5359.705216213146, 5396.0, 5490.725463726878, 5515.7865269640615, 8843.248323892283, 8952.0, 8997.37018408705, 9037.864432033393, 9070.501122438329, 8799.340049496186, 9001.054889236535, 9127.041660625538, 9157.633694652139, 9202.217811486098, 6085.847853803691, 6479.870402592016, 6632.0, 6660.666966651745, 6917.308269173243, 7566.470347075872, 7584.051993500812, 7621.161672215941, 7654.0, 7665.923340766521, 6839.89740153908, 6970.581765094111, 7022.508424410242, 7091.219965803861, 7102.360787529147, 6853.965730171317, 6882.0, 6901.102856628606, 6978.406835419046, 6986.266442023514, 6340.239171299474, 6343.365663433804, 6383.457406120346, 6398.232212134573, 6402.35976402356, 4696.38946936896, 4758.1435341638835, 4776.641751868554, 4778.904421911612, 4806.663533552618, 4760.904781904412, 4771.76141192932, 4813.181759101031, 4855.902881942271, 4862.489438608895], "value": 4139.544771123774, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.19907234233557, 317.62678852348495, 322.2700583179099, 325.81754217638127, 325.83382474937775, 4968.0, 4976.900461990758, 4986.551210391064, 5042.773075211615, 5048.469910659383, 5021.196608542634, 5023.648344615878, 5024.748762561866, 5041.218611115274, 5045.243213517974, 3688.6311368863167, 3801.505804245458, 3931.1351502669368, 3971.0270983609057, 3984.6413822755944, 3950.2494526040105, 3966.960330396688, 3971.3645816669336, 3975.1254723960683, 3977.8011099445057, 3739.9252014959684, 3944.3097457944746, 3946.427767973642, 3947.585503522132, 3952.604739526039, 3797.677197438221, 3963.2667956427863, 3964.6233607807358, 3977.3238549446664, 3985.3025720499086, 3503.1067077894972, 3515.1036485695986, 3515.2442224921765, 3523.5419395478425, 3530.5939816921127, 4767.880802979918, 4780.450248221464, 4784.162771515006, 4786.2581299898575, 4797.688150270256, 4206.810693518799, 4452.510223875371, 4454.57681520255, 4454.799534020977, 4496.505384407713, 5201.505856943584, 5204.947950520522, 5218.6868787872845, 5227.085260079509, 5236.633435659505, 3730.7201959852846, 3732.0, 3735.383661695817, 3735.477033215325, 3736.346139425617, 5186.896262074775, 5442.156465747816, 5500.80747173851, 5516.503514683657, 5523.861903452405, 3791.5829258781514, 3802.4676545283683, 3806.8286927087793, 3810.599887011879, 3812.6187381262207, 3853.7687738735203, 3865.265599536079, 3870.148567315186, 3870.9806450967567, 3875.6318149775725, 4264.445622069174, 4413.536578659258, 4417.160739459557, 4421.579949904753, 4436.800343984464, 5210.76551555181, 5217.791288348423, 5240.292560504359, 5246.160614301693, 5252.684838909678, 1309.306067784076, 1332.2273081612834, 1336.832895888014, 1337.1375462826422, 1341.530464337474, 830.7424698343533, 894.3337213775778, 902.8420026495469, 906.9002409734924, 915.2632131134368, 4559.886002849956, 4575.9084818303445, 4579.656525760582, 4621.2837010263465, 4625.907481850344, 5369.892602147936, 5378.489043540857, 5378.569714422837, 5388.649737767033, 5395.352557693023, 4457.885528617846, 4612.976935115303, 4615.2769865779355, 4629.189891768927, 4631.722096674211, 2851.615031970699, 2859.156548818062, 2873.2242294580346, 2874.8131371460786, 2883.1206482023185, 5042.7982880685095, 5074.340335756402, 5087.618428617869, 5106.080905436983, 5117.181250999822, 5251.897101608629, 5448.427915068861, 5460.453954604587, 5461.596897365147, 5472.015037293246, 5042.445331013659, 5068.442471328077, 5077.390713114376, 5078.847634570969, 5080.415752188472, 5307.893842123213, 5321.494458026481, 5322.600804939568, 5329.813456529158, 5340.652857564246, 5041.924371134362, 5219.19102539107, 5314.707691077027, 5315.521603055744, 5328.0, 5122.948770512247, 5129.589632829439, 5135.0, 5148.819791307286, 5174.353205849269, 3791.1469919267943, 3827.808609569566, 3832.5400951885954, 3834.1181528248103, 3841.5966323535627, 5178.689278643294, 5391.919121213106, 5394.460553944731, 5410.404855465974, 5449.945500544944, 5212.713300768494, 5246.3704355477585, 5255.737213139251, 5256.763445645031, 5260.579153667621, 5181.53366197029, 5250.474952504719, 5265.051211591306, 5270.472952704698, 5274.841754747364, 5163.406208285945, 5186.092433824141, 5192.091384007859, 5192.74036298176, 5192.896142077062, 5023.6985780853265, 5076.466970967996, 5226.947730522646, 5273.841784746463, 5287.154055351125, 5127.5128862759475, 5143.254228136974, 5146.022255771391, 5167.0, 5193.610479213999], "value": 3953.1862689981017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.0600976661974, 699.2867275379114, 710.119451879669, 714.885618301072, 714.9463790215732, 10707.25049246552, 10986.670399887997, 10995.725106872333, 11012.17408694347, 11015.118790496761, 11278.041366483858, 11339.319640821557, 11343.092552595794, 11343.149263805206, 11357.261777984426, 635.8791829552371, 786.4730630477566, 801.3789313282194, 815.355868863597, 820.4543978254484, 805.730080423056, 805.9113497515268, 811.3265989228926, 811.4117264982899, 811.9188081191893, 856.5203486047833, 858.5406807358065, 858.5921687198593, 860.0926023045685, 860.389123722158, 667.1893649216202, 679.8742232686968, 681.6319187638669, 818.0592318833329, 853.7950891785957, 624.3413199074975, 625.8310256230837, 626.2703949898363, 626.6991843914901, 627.0468887291337, 11850.585229517012, 11866.0, 11906.880931190664, 11908.0, 11936.104792140537, 13076.803847942288, 13321.66695832612, 13526.256055916921, 13670.384832682554, 13689.931550342284, 9296.816432605354, 9459.479728614924, 9621.470819105016, 9631.518424078768, 9826.508674566243, 2938.911832645024, 2942.1320710390487, 3083.799553029068, 3179.920501987469, 3433.364827506919, 45562.77218613919, 46089.0, 46252.53747462516, 46279.30581041287, 47171.99999999966, 10051.346662466916, 10101.343412678152, 10147.238957078249, 10151.847722284172, 10356.792864142675, 16911.49265522036, 17059.829401705825, 17077.48767536951, 17137.828621713623, 18200.089995500435, 6119.785807496716, 6121.173641558422, 6140.293866205354, 6194.876102477925, 6242.500599951993, 3407.454807230831, 3410.84651190697, 3429.0570093224565, 3479.7216222702123, 3486.8082255476193, 2672.665916760405, 2711.1188863619404, 2754.4215714700135, 2761.5995680626197, 2763.668359796837, 498.9875253118701, 506.08903972848725, 515.1088616693067, 516.2024671881951, 521.4707072321521, 540.5837505121035, 565.3667891960948, 572.4275724275724, 576.8903908257417, 596.9731362088717, 7199.964000179965, 7251.673674684652, 7389.556626602421, 7501.849963000818, 7684.961575192088, 549.8158117030839, 551.9944800551943, 554.9056660367747, 556.2462862820901, 561.5591760468013, 3412.692857642824, 3555.9288814224087, 3571.2857428514403, 3632.9636703633155, 3672.7429079964145, 45967.0, 46255.5374446258, 47190.76404617955, 47254.0, 47721.5227847724, 40660.59339406568, 42238.15523689509, 42551.57448425538, 42699.35103127192, 42857.57142428536, 37467.06332341659, 37837.62162378341, 38154.9476041916, 38688.80655596704, 39219.21561568753, 7994.2405471480115, 8081.515109093473, 8111.797205069921, 8253.95873020631, 8279.089300177096, 28402.29586224833, 28462.57306140451, 28962.27594310159, 29029.564556532092, 29084.1274761749, 33894.0, 36444.63555364519, 36836.81581592075, 36966.63033369632, 37468.0, 9807.85288220663, 10344.172466202835, 10344.586216551254, 10568.947155264175, 10572.947135264274, 11795.056395488169, 11801.114916381477, 11853.5851245206, 11866.288022718665, 11935.224210426295, 9900.603975841173, 9986.800263994533, 10210.285280030326, 10218.335808172445, 10365.326253793479, 10080.84878726805, 10096.444695541815, 10185.134263587677, 10208.693739187836, 10410.635627752992, 10665.573377064831, 10686.305390149615, 10725.410102444128, 10881.891181088087, 11518.07855371585, 9313.580888860153, 9395.530223488935, 9456.101670341306, 9630.759231019281, 9630.903690963001, 9061.365704400629, 9592.280578956466, 9603.567839447102, 9691.951540242253, 9731.805363892825], "value": 5706.730727175574, "unit": "score"}], "name": "dromaeo_css", "value": 6291.797951075839, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 107.0, 111.0, 116.0, 114.0, 103.0, 112.0, 112.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 139.0, 163.0, 190.0, 134.0, 174.0, 155.0, 139.0, 183.0, 136.0], "value": 157.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 163.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 110.0, 107.0, 75.0, 74.0, 74.0, 108.0, 104.0, 73.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 154.0, 94.0, 95.0, 95.0, 142.0, 94.0, 93.0, 147.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 90.0, 63.0, 62.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 77.0, 88.0, 79.0, 79.0, 78.0, 79.0, 80.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 133.0, 131.0, 131.0, 133.0, 131.0, 133.0, 172.0, 136.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 173.0, 170.0, 170.0, 172.0, 169.0, 171.0, 175.0, 172.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 72.0, 72.0, 72.0, 72.0, 72.0, 72.0, 71.0, 71.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1578.6999999999998, "alertThreshold": 2.0}]} 06:28:19 INFO - Return code: 0 06:28:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:28:19 ERROR - # TBPL SUCCESS # 06:28:19 INFO - Running post-action listener: _resource_record_post_action 06:28:19 INFO - Running post-run listener: _resource_record_post_run 06:28:21 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519081984; Read time: 12; Write time: 850688 06:28:21 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 241168384; Read time: 0; Write time: 559396 06:28:21 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277913600; Read time: 12; Write time: 291292 06:28:21 INFO - Running post-run listener: _upload_blobber_files 06:28:21 INFO - Blob upload gear active. 06:28:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:28:21 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 06:28:21 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'] 06:28:21 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 06:28:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:28:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:28:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:28:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:28:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:28:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:28:22 INFO - (blobuploader) - INFO - Done attempting. 06:28:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:28:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:28:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:28:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:28:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:28:23 INFO - (blobuploader) - INFO - Done attempting. 06:28:23 INFO - (blobuploader) - INFO - Iteration through files over. 06:28:23 INFO - Return code: 0 06:28:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:28:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:28:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00e50087f6f1321718cc2340bf1da31b49886695d92c67019455254e5f33283512bf3cb58d7f37748ab4d37c14fdc4c2c7ca6761fa155a9ae286dacfb43f52d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/beecb37c454bec814e209877f7efd06c5de97dadc320ee7eef9c1592e803cfc7c573b9b1928a11ead4e59da21b0c6c784e42034a399293b6298756f3441156ae"} 06:28:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:28:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:28:23 INFO - Contents: 06:28:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00e50087f6f1321718cc2340bf1da31b49886695d92c67019455254e5f33283512bf3cb58d7f37748ab4d37c14fdc4c2c7ca6761fa155a9ae286dacfb43f52d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/beecb37c454bec814e209877f7efd06c5de97dadc320ee7eef9c1592e803cfc7c573b9b1928a11ead4e59da21b0c6c784e42034a399293b6298756f3441156ae"} 06:28:23 INFO - Running post-run listener: copy_logs_to_upload_dir 06:28:23 INFO - Copying logs to upload dir... 06:28:23 INFO - mkdir: /builds/slave/test/build/upload/logs 06:28:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.734148 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 06:28:23.066765) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:23.070356) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043 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/00e50087f6f1321718cc2340bf1da31b49886695d92c67019455254e5f33283512bf3cb58d7f37748ab4d37c14fdc4c2c7ca6761fa155a9ae286dacfb43f52d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/beecb37c454bec814e209877f7efd06c5de97dadc320ee7eef9c1592e803cfc7c573b9b1928a11ead4e59da21b0c6c784e42034a399293b6298756f3441156ae"} build_url:https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/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/00e50087f6f1321718cc2340bf1da31b49886695d92c67019455254e5f33283512bf3cb58d7f37748ab4d37c14fdc4c2c7ca6761fa155a9ae286dacfb43f52d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/beecb37c454bec814e209877f7efd06c5de97dadc320ee7eef9c1592e803cfc7c573b9b1928a11ead4e59da21b0c6c784e42034a399293b6298756f3441156ae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:23.094985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:23.095290) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461330463.355180-16996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:23.179912) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:28:23.180236) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:28:23.180538) ========= ========= Total master_lag: 0.81 =========