builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1461064633.94 results: success (0) buildid: 20160419025852 builduid: 05ee8ce5db5c4583a3ac3f2dcaf9c7bb revision: 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:13.944621) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:13.945068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:13.945352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:13.961922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:13.962259) ========= 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=836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 04:17:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-04-19 04:17:14 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:14.145958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:14.146487) ========= 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=836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017385 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:14.197031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:14.197449) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 --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=836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 04:17:14,882 truncating revision to first 12 chars 2016-04-19 04:17:14,882 Setting DEBUG logging. 2016-04-19 04:17:14,882 attempt 1/10 2016-04-19 04:17:14,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9a8ff2f49784?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 04:17:15,381 unpacking tar archive at: mozilla-central-9a8ff2f49784/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776954 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:14.987222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:14.987547) ========= script_repo_revision: 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:14.987937) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:14.988224) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 04:17:14.998090) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-19 04:17:14.998373) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:17:15 INFO - MultiFileLogger online at 20160419 04:17:15 in /builds/slave/test 04:17:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:17:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:17:15 INFO - {'append_to_log': False, 04:17:15 INFO - 'base_work_dir': '/builds/slave/test', 04:17:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:17:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:17:15 INFO - 'branch': 'Firefox-Non-PGO', 04:17:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:17:15 INFO - 'config_files': ('talos/linux_config.py',), 04:17:15 INFO - 'default_actions': ('clobber', 04:17:15 INFO - 'read-buildbot-config', 04:17:15 INFO - 'download-and-extract', 04:17:15 INFO - 'populate-webroot', 04:17:15 INFO - 'create-virtualenv', 04:17:15 INFO - 'install', 04:17:15 INFO - 'run-tests'), 04:17:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:17:15 INFO - 'download_minidump_stackwalk': True, 04:17:15 INFO - 'download_symbols': 'ondemand', 04:17:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:17:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:17:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:17:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:17:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:17:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:17:15 INFO - 'installer_path': 'installer.exe', 04:17:15 INFO - 'log_level': 'info', 04:17:15 INFO - 'log_name': 'talos', 04:17:15 INFO - 'log_to_console': True, 04:17:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:17:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:17:15 INFO - 'opt_config_files': (), 04:17:15 INFO - 'pip_index': False, 04:17:15 INFO - 'sps_profile': False, 04:17:15 INFO - 'sps_profile_interval': 0, 04:17:15 INFO - 'suite': 'dromaeojs', 04:17:15 INFO - 'system_bits': '32', 04:17:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:17:15 INFO - 'title': 'talos-linux64-ix-028', 04:17:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:17:15 INFO - 'use_talos_json': True, 04:17:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:17:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:17:15 INFO - 'work_dir': 'build'} 04:17:15 INFO - ##### 04:17:15 INFO - ##### Running clobber step. 04:17:15 INFO - ##### 04:17:15 INFO - Running pre-action listener: _resource_record_pre_action 04:17:15 INFO - Running main action method: clobber 04:17:15 INFO - rmtree: /builds/slave/test/build 04:17:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:17:16 INFO - Running post-action listener: _resource_record_post_action 04:17:16 INFO - ##### 04:17:16 INFO - ##### Running read-buildbot-config step. 04:17:16 INFO - ##### 04:17:16 INFO - Running pre-action listener: _resource_record_pre_action 04:17:16 INFO - Running main action method: read_buildbot_config 04:17:16 INFO - Using buildbot properties: 04:17:16 INFO - { 04:17:16 INFO - "project": "", 04:17:16 INFO - "product": "firefox", 04:17:16 INFO - "script_repo_revision": "production", 04:17:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:17:16 INFO - "repository": "", 04:17:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:17:16 INFO - "buildid": "20160419025852", 04:17:16 INFO - "pgo_build": "False", 04:17:16 INFO - "basedir": "/builds/slave/test", 04:17:16 INFO - "buildnumber": 551, 04:17:16 INFO - "slavename": "talos-linux64-ix-028", 04:17:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:17:16 INFO - "platform": "ubuntu64_hw", 04:17:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:17:16 INFO - "branch": "mozilla-central", 04:17:16 INFO - "repo_path": "mozilla-central", 04:17:16 INFO - "revision": "9a8ff2f4978493c3fd9982652a09ffcdf2333a75", 04:17:16 INFO - "stage_platform": "linux64", 04:17:16 INFO - "builduid": "05ee8ce5db5c4583a3ac3f2dcaf9c7bb", 04:17:16 INFO - "slavebuilddir": "test" 04:17:16 INFO - } 04:17:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:17:16 INFO - Running post-action listener: _resource_record_post_action 04:17:16 INFO - ##### 04:17:16 INFO - ##### Running download-and-extract step. 04:17:16 INFO - ##### 04:17:16 INFO - Running pre-action listener: _resource_record_pre_action 04:17:16 INFO - Running main action method: download_and_extract 04:17:16 INFO - mkdir: /builds/slave/test/build/tests 04:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:16 INFO - https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:17:19 INFO - Downloaded 1361 bytes. 04:17:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:17:19 INFO - Using the following test package requirements: 04:17:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:17:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:17:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:17:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:19 INFO - u'jsshell-linux-x86_64.zip'], 04:17:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:17:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:17:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:17:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:17:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:17:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:17:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:19 INFO - https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:17:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:17:21 INFO - Downloaded 22209354 bytes. 04:17:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:17:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:17:22 INFO - Return code: 0 04:17:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:22 INFO - https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:17:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:17:26 INFO - Downloaded 22209354 bytes. 04:17:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:17:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:17:28 INFO - Return code: 0 04:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:28 INFO - https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:17:29 INFO - Downloaded 10845952 bytes. 04:17:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:17:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:17:29 INFO - Return code: 0 04:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:29 INFO - https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:17:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:17:30 INFO - Downloaded 54455783 bytes. 04:17:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:30 INFO - mkdir: /builds/slave/test/properties 04:17:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:17:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:17:30 INFO - Contents: 04:17:30 INFO - build_url:https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:31 INFO - Running post-action listener: _resource_record_post_action 04:17:31 INFO - Running post-action listener: set_extra_try_arguments 04:17:31 INFO - ##### 04:17:31 INFO - ##### Running populate-webroot step. 04:17:31 INFO - ##### 04:17:31 INFO - Running pre-action listener: _resource_record_pre_action 04:17:31 INFO - Running main action method: populate_webroot 04:17:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:17:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:17:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:17:31 INFO - '--tppagecycles', 04:17:31 INFO - '7'], 04:17:31 INFO - 'tests': ['tsvgm']}}, 04:17:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:17:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:17:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:17:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:17:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:31 INFO - 'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:31 INFO - 'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['damp', 'tps']}, 04:17:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:31 INFO - 'tests': ['damp', 'tps']}, 04:17:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['dromaeo_dom']}, 04:17:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:17:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['a11yr', 04:17:31 INFO - 'ts_paint', 04:17:31 INFO - 'tpaint', 04:17:31 INFO - 'sessionrestore', 04:17:31 INFO - 'sessionrestore_no_auto_restore', 04:17:31 INFO - 'tabpaint']}, 04:17:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:17:31 INFO - 'ts_paint', 04:17:31 INFO - 'tpaint', 04:17:31 INFO - 'sessionrestore', 04:17:31 INFO - 'sessionrestore_no_auto_restore', 04:17:31 INFO - 'tabpaint']}, 04:17:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:17:31 INFO - 'ts_paint', 04:17:31 INFO - 'tpaint', 04:17:31 INFO - 'sessionrestore', 04:17:31 INFO - 'sessionrestore_no_auto_restore', 04:17:31 INFO - 'tabpaint']}, 04:17:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:17:31 INFO - 'ts_paint', 04:17:31 INFO - 'tpaint', 04:17:31 INFO - 'sessionrestore', 04:17:31 INFO - 'sessionrestore_no_auto_restore', 04:17:31 INFO - 'tabpaint']}, 04:17:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['a11yr', 04:17:31 INFO - 'ts_paint', 04:17:31 INFO - 'tpaint', 04:17:31 INFO - 'sessionrestore', 04:17:31 INFO - 'sessionrestore_no_auto_restore', 04:17:31 INFO - 'tabpaint']}, 04:17:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['a11yr', 04:17:31 INFO - 'ts_paint', 04:17:31 INFO - 'tpaint', 04:17:31 INFO - 'sessionrestore', 04:17:31 INFO - 'sessionrestore_no_auto_restore', 04:17:31 INFO - 'tabpaint']}, 04:17:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['tsvgx', 04:17:31 INFO - 'tsvgr_opacity', 04:17:31 INFO - 'tart', 04:17:31 INFO - 'tscrollx', 04:17:31 INFO - 'cart']}, 04:17:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:17:31 INFO - 'tsvgr_opacity', 04:17:31 INFO - 'tart', 04:17:31 INFO - 'tscrollx', 04:17:31 INFO - 'cart']}, 04:17:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:31 INFO - 'talos_options': ['--disable-e10s'], 04:17:31 INFO - 'tests': ['tp5o']}, 04:17:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:31 INFO - 'tests': ['tp5o']}, 04:17:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:31 INFO - 'talos_options': ['--disable-e10s', 04:17:31 INFO - '--xperf_path', 04:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:31 INFO - 'tests': ['tp5n']}, 04:17:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:31 INFO - 'talos_options': ['--xperf_path', 04:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:31 INFO - 'tests': ['tp5n']}}, 04:17:31 INFO - 'talos.zip': {'path': '', 04:17:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:17:31 INFO - Running post-action listener: _resource_record_post_action 04:17:31 INFO - ##### 04:17:31 INFO - ##### Running create-virtualenv step. 04:17:31 INFO - ##### 04:17:31 INFO - Running pre-action listener: _resource_record_pre_action 04:17:31 INFO - Running main action method: create_virtualenv 04:17:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:17:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:17:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:17:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:17:31 INFO - Using real prefix '/usr' 04:17:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:17:31 INFO - Installing distribute.............................................................................................................................................................................................done. 04:17:33 INFO - Installing pip.................done. 04:17:33 INFO - Return code: 0 04:17:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49d54dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, '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': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:17:33 INFO - Using env: {'DISPLAY': ':0', 04:17:33 INFO - 'HOME': '/home/cltbld', 04:17:33 INFO - 'LANG': 'en_US.UTF-8', 04:17:33 INFO - 'LANGUAGE': 'en_US:en', 04:17:33 INFO - 'LOGNAME': 'cltbld', 04:17:33 INFO - 'MAIL': '/var/mail/cltbld', 04:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:33 INFO - 'MOZ_NO_REMOTE': '1', 04:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:33 INFO - 'NO_EM_RESTART': '1', 04:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:33 INFO - 'PWD': '/builds/slave/test', 04:17:33 INFO - 'SHELL': '/bin/bash', 04:17:33 INFO - 'SHLVL': '1', 04:17:33 INFO - 'TERM': 'linux', 04:17:33 INFO - 'TMOUT': '86400', 04:17:33 INFO - 'USER': 'cltbld', 04:17:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:33 INFO - '_': '/tools/buildbot/bin/python'} 04:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:17:34 INFO - Cleaning up... 04:17:34 INFO - Return code: 0 04:17:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49d54dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, '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': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:17:34 INFO - Using env: {'DISPLAY': ':0', 04:17:34 INFO - 'HOME': '/home/cltbld', 04:17:34 INFO - 'LANG': 'en_US.UTF-8', 04:17:34 INFO - 'LANGUAGE': 'en_US:en', 04:17:34 INFO - 'LOGNAME': 'cltbld', 04:17:34 INFO - 'MAIL': '/var/mail/cltbld', 04:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:34 INFO - 'MOZ_NO_REMOTE': '1', 04:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:34 INFO - 'NO_EM_RESTART': '1', 04:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:34 INFO - 'PWD': '/builds/slave/test', 04:17:34 INFO - 'SHELL': '/bin/bash', 04:17:34 INFO - 'SHLVL': '1', 04:17:34 INFO - 'TERM': 'linux', 04:17:34 INFO - 'TMOUT': '86400', 04:17:34 INFO - 'USER': 'cltbld', 04:17:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:34 INFO - '_': '/tools/buildbot/bin/python'} 04:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:34 INFO - Downloading/unpacking psutil>=0.7.1 04:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:17:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:36 INFO - Installing collected packages: psutil 04:17:36 INFO - Running setup.py install for psutil 04:17:36 INFO - building 'psutil._psutil_linux' extension 04:17:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:17:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:17:36 INFO - building 'psutil._psutil_posix' extension 04:17:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:17:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:17:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:36 INFO - Successfully installed psutil 04:17:36 INFO - Cleaning up... 04:17:36 INFO - Return code: 0 04:17:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49d54dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, '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': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:17:36 INFO - Using env: {'DISPLAY': ':0', 04:17:36 INFO - 'HOME': '/home/cltbld', 04:17:36 INFO - 'LANG': 'en_US.UTF-8', 04:17:36 INFO - 'LANGUAGE': 'en_US:en', 04:17:36 INFO - 'LOGNAME': 'cltbld', 04:17:36 INFO - 'MAIL': '/var/mail/cltbld', 04:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:36 INFO - 'MOZ_NO_REMOTE': '1', 04:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:36 INFO - 'NO_EM_RESTART': '1', 04:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:36 INFO - 'PWD': '/builds/slave/test', 04:17:36 INFO - 'SHELL': '/bin/bash', 04:17:36 INFO - 'SHLVL': '1', 04:17:36 INFO - 'TERM': 'linux', 04:17:36 INFO - 'TMOUT': '86400', 04:17:36 INFO - 'USER': 'cltbld', 04:17:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:36 INFO - '_': '/tools/buildbot/bin/python'} 04:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:17:39 INFO - Installing collected packages: mozsystemmonitor 04:17:39 INFO - Running setup.py install for mozsystemmonitor 04:17:39 INFO - Successfully installed mozsystemmonitor 04:17:39 INFO - Cleaning up... 04:17:39 INFO - Return code: 0 04:17:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49d54dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, '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': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:17:39 INFO - Using env: {'DISPLAY': ':0', 04:17:39 INFO - 'HOME': '/home/cltbld', 04:17:39 INFO - 'LANG': 'en_US.UTF-8', 04:17:39 INFO - 'LANGUAGE': 'en_US:en', 04:17:39 INFO - 'LOGNAME': 'cltbld', 04:17:39 INFO - 'MAIL': '/var/mail/cltbld', 04:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:39 INFO - 'MOZ_NO_REMOTE': '1', 04:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:39 INFO - 'NO_EM_RESTART': '1', 04:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:39 INFO - 'PWD': '/builds/slave/test', 04:17:39 INFO - 'SHELL': '/bin/bash', 04:17:39 INFO - 'SHLVL': '1', 04:17:39 INFO - 'TERM': 'linux', 04:17:39 INFO - 'TMOUT': '86400', 04:17:39 INFO - 'USER': 'cltbld', 04:17:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:39 INFO - '_': '/tools/buildbot/bin/python'} 04:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:17:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:42 INFO - Downloading docopt-0.6.1.tar.gz 04:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:17:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:17:42 INFO - Running setup.py install for blobuploader 04:17:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:17:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:17:42 INFO - Running setup.py install for requests 04:17:42 INFO - Running setup.py install for docopt 04:17:42 INFO - Successfully installed blobuploader requests docopt 04:17:42 INFO - Cleaning up... 04:17:42 INFO - Return code: 0 04:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49d54dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, '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': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:17:42 INFO - Using env: {'DISPLAY': ':0', 04:17:42 INFO - 'HOME': '/home/cltbld', 04:17:42 INFO - 'LANG': 'en_US.UTF-8', 04:17:42 INFO - 'LANGUAGE': 'en_US:en', 04:17:42 INFO - 'LOGNAME': 'cltbld', 04:17:42 INFO - 'MAIL': '/var/mail/cltbld', 04:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:42 INFO - 'MOZ_NO_REMOTE': '1', 04:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:42 INFO - 'NO_EM_RESTART': '1', 04:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:42 INFO - 'PWD': '/builds/slave/test', 04:17:42 INFO - 'SHELL': '/bin/bash', 04:17:42 INFO - 'SHLVL': '1', 04:17:42 INFO - 'TERM': 'linux', 04:17:42 INFO - 'TMOUT': '86400', 04:17:42 INFO - 'USER': 'cltbld', 04:17:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:42 INFO - '_': '/tools/buildbot/bin/python'} 04:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:42 INFO - Running setup.py (path:/tmp/pip-NK1KRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:43 INFO - Running setup.py (path:/tmp/pip-BNla8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:43 INFO - Running setup.py (path:/tmp/pip-Txmf7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:43 INFO - Running setup.py (path:/tmp/pip-vpeN4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:43 INFO - Running setup.py (path:/tmp/pip-9ojN6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:43 INFO - Running setup.py (path:/tmp/pip-ziUVo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:43 INFO - Running setup.py (path:/tmp/pip-3PTmli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:43 INFO - Running setup.py (path:/tmp/pip-xEocFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:43 INFO - Running setup.py (path:/tmp/pip-EhnZ5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:43 INFO - Running setup.py (path:/tmp/pip-4HgeGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:43 INFO - Running setup.py (path:/tmp/pip-9Q9ko8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:43 INFO - Running setup.py (path:/tmp/pip-upUkeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:43 INFO - Running setup.py (path:/tmp/pip-muHR3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:43 INFO - Running setup.py (path:/tmp/pip-1h2WMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:43 INFO - Running setup.py (path:/tmp/pip-1DyhCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:44 INFO - Running setup.py (path:/tmp/pip-FeNwvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:44 INFO - Running setup.py (path:/tmp/pip-WMeKC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:17:44 INFO - Running setup.py install for manifestparser 04:17:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:17:44 INFO - Running setup.py install for mozcrash 04:17:44 INFO - Running setup.py install for mozdebug 04:17:44 INFO - Running setup.py install for mozdevice 04:17:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:17:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:17:44 INFO - Running setup.py install for mozfile 04:17:44 INFO - Running setup.py install for mozhttpd 04:17:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:44 INFO - Running setup.py install for mozinfo 04:17:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:44 INFO - Running setup.py install for mozInstall 04:17:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:45 INFO - Running setup.py install for mozleak 04:17:45 INFO - Running setup.py install for mozlog 04:17:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:45 INFO - Running setup.py install for moznetwork 04:17:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:45 INFO - Running setup.py install for mozprocess 04:17:45 INFO - Running setup.py install for mozprofile 04:17:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:45 INFO - Running setup.py install for mozrunner 04:17:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:45 INFO - Running setup.py install for mozscreenshot 04:17:45 INFO - Running setup.py install for moztest 04:17:45 INFO - Running setup.py install for mozversion 04:17:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:45 INFO - Cleaning up... 04:17:45 INFO - Return code: 0 04:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49d54dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, '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': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:17:45 INFO - Using env: {'DISPLAY': ':0', 04:17:45 INFO - 'HOME': '/home/cltbld', 04:17:45 INFO - 'LANG': 'en_US.UTF-8', 04:17:45 INFO - 'LANGUAGE': 'en_US:en', 04:17:45 INFO - 'LOGNAME': 'cltbld', 04:17:45 INFO - 'MAIL': '/var/mail/cltbld', 04:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:45 INFO - 'MOZ_NO_REMOTE': '1', 04:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:45 INFO - 'NO_EM_RESTART': '1', 04:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:45 INFO - 'PWD': '/builds/slave/test', 04:17:45 INFO - 'SHELL': '/bin/bash', 04:17:45 INFO - 'SHLVL': '1', 04:17:45 INFO - 'TERM': 'linux', 04:17:45 INFO - 'TMOUT': '86400', 04:17:45 INFO - 'USER': 'cltbld', 04:17:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:45 INFO - '_': '/tools/buildbot/bin/python'} 04:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:46 INFO - Running setup.py (path:/tmp/pip-lLLiKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:46 INFO - Running setup.py (path:/tmp/pip-9Oc0he-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:46 INFO - Running setup.py (path:/tmp/pip-Yr7ZGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:46 INFO - Running setup.py (path:/tmp/pip-2GJ53y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:46 INFO - Running setup.py (path:/tmp/pip-FeTVkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:46 INFO - Running setup.py (path:/tmp/pip-iIHaHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:46 INFO - Running setup.py (path:/tmp/pip-oU7aMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:46 INFO - Running setup.py (path:/tmp/pip-EjxI4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:46 INFO - Running setup.py (path:/tmp/pip-S09HB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:46 INFO - Running setup.py (path:/tmp/pip-5G0D6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:46 INFO - Running setup.py (path:/tmp/pip-NcAQmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:47 INFO - Running setup.py (path:/tmp/pip-rxV8uR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:47 INFO - Running setup.py (path:/tmp/pip-mraArA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:47 INFO - Running setup.py (path:/tmp/pip-9hcFnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:47 INFO - Running setup.py (path:/tmp/pip-m3h1E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:47 INFO - Running setup.py (path:/tmp/pip-3Ej573-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:47 INFO - Running setup.py (path:/tmp/pip-RdCK4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:49 INFO - Downloading blessings-1.6.tar.gz 04:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:49 INFO - Installing collected packages: blessings 04:17:49 INFO - Running setup.py install for blessings 04:17:49 INFO - Successfully installed blessings 04:17:49 INFO - Cleaning up... 04:17:49 INFO - Return code: 0 04:17:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:49 INFO - Reading from file tmpfile_stdout 04:17:49 INFO - Current package versions: 04:17:49 INFO - argparse == 1.2.1 04:17:49 INFO - blessings == 1.6 04:17:49 INFO - blobuploader == 1.2.4 04:17:49 INFO - docopt == 0.6.1 04:17:49 INFO - manifestparser == 1.1 04:17:49 INFO - mozInstall == 1.12 04:17:49 INFO - mozcrash == 0.17 04:17:49 INFO - mozdebug == 0.1 04:17:49 INFO - mozdevice == 0.48 04:17:49 INFO - mozfile == 1.2 04:17:49 INFO - mozhttpd == 0.7 04:17:49 INFO - mozinfo == 0.9 04:17:49 INFO - mozleak == 0.1 04:17:49 INFO - mozlog == 3.1 04:17:49 INFO - moznetwork == 0.27 04:17:49 INFO - mozprocess == 0.22 04:17:49 INFO - mozprofile == 0.28 04:17:49 INFO - mozrunner == 6.11 04:17:49 INFO - mozscreenshot == 0.1 04:17:49 INFO - mozsystemmonitor == 0.0 04:17:49 INFO - moztest == 0.7 04:17:49 INFO - mozversion == 1.4 04:17:49 INFO - psutil == 3.1.1 04:17:49 INFO - requests == 1.2.3 04:17:49 INFO - wsgiref == 0.1.2 04:17:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49d54dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, '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': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:17:49 INFO - Using env: {'DISPLAY': ':0', 04:17:49 INFO - 'HOME': '/home/cltbld', 04:17:49 INFO - 'LANG': 'en_US.UTF-8', 04:17:49 INFO - 'LANGUAGE': 'en_US:en', 04:17:49 INFO - 'LOGNAME': 'cltbld', 04:17:49 INFO - 'MAIL': '/var/mail/cltbld', 04:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:49 INFO - 'MOZ_NO_REMOTE': '1', 04:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:49 INFO - 'NO_EM_RESTART': '1', 04:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:49 INFO - 'PWD': '/builds/slave/test', 04:17:49 INFO - 'SHELL': '/bin/bash', 04:17:49 INFO - 'SHLVL': '1', 04:17:49 INFO - 'TERM': 'linux', 04:17:49 INFO - 'TMOUT': '86400', 04:17:49 INFO - 'USER': 'cltbld', 04:17:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:49 INFO - '_': '/tools/buildbot/bin/python'} 04:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:17:49 INFO - Cleaning up... 04:17:50 INFO - Return code: 0 04:17:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49d54dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, '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': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:17:50 INFO - Using env: {'DISPLAY': ':0', 04:17:50 INFO - 'HOME': '/home/cltbld', 04:17:50 INFO - 'LANG': 'en_US.UTF-8', 04:17:50 INFO - 'LANGUAGE': 'en_US:en', 04:17:50 INFO - 'LOGNAME': 'cltbld', 04:17:50 INFO - 'MAIL': '/var/mail/cltbld', 04:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:50 INFO - 'MOZ_NO_REMOTE': '1', 04:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:50 INFO - 'NO_EM_RESTART': '1', 04:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:50 INFO - 'PWD': '/builds/slave/test', 04:17:50 INFO - 'SHELL': '/bin/bash', 04:17:50 INFO - 'SHLVL': '1', 04:17:50 INFO - 'TERM': 'linux', 04:17:50 INFO - 'TMOUT': '86400', 04:17:50 INFO - 'USER': 'cltbld', 04:17:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:50 INFO - '_': '/tools/buildbot/bin/python'} 04:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:50 INFO - Downloading/unpacking jsonschema 04:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:52 INFO - Downloading/unpacking functools32 (from jsonschema) 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:52 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:52 INFO - warning: no files found matching '*.txt' 04:17:52 INFO - no previously-included directories found matching 'build' 04:17:52 INFO - no previously-included directories found matching 'dist' 04:17:52 INFO - no previously-included directories found matching '.git*' 04:17:52 INFO - Installing collected packages: jsonschema, functools32 04:17:52 INFO - Running setup.py install for functools32 04:17:52 INFO - warning: no files found matching '*.txt' 04:17:52 INFO - no previously-included directories found matching 'build' 04:17:52 INFO - no previously-included directories found matching 'dist' 04:17:52 INFO - no previously-included directories found matching '.git*' 04:17:52 INFO - Successfully installed jsonschema functools32 04:17:52 INFO - Cleaning up... 04:17:52 INFO - Return code: 0 04:17:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:52 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 0x7f49d54dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, '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': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:17:52 INFO - Using env: {'DISPLAY': ':0', 04:17:52 INFO - 'HOME': '/home/cltbld', 04:17:52 INFO - 'LANG': 'en_US.UTF-8', 04:17:52 INFO - 'LANGUAGE': 'en_US:en', 04:17:52 INFO - 'LOGNAME': 'cltbld', 04:17:52 INFO - 'MAIL': '/var/mail/cltbld', 04:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:52 INFO - 'MOZ_NO_REMOTE': '1', 04:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:52 INFO - 'NO_EM_RESTART': '1', 04:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:52 INFO - 'PWD': '/builds/slave/test', 04:17:52 INFO - 'SHELL': '/bin/bash', 04:17:52 INFO - 'SHLVL': '1', 04:17:52 INFO - 'TERM': 'linux', 04:17:52 INFO - 'TMOUT': '86400', 04:17:52 INFO - 'USER': 'cltbld', 04:17:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:52 INFO - '_': '/tools/buildbot/bin/python'} 04:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:52 INFO - Downloading/unpacking flake8 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:17:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:17:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:17:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:55 INFO - no previously-included directories found matching 'docs/_build' 04:17:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:17:55 INFO - Running setup.py install for pep8 04:17:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:55 INFO - no previously-included directories found matching 'docs/_build' 04:17:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:17:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:17:55 INFO - Cleaning up... 04:17:55 INFO - Return code: 0 04:17:55 INFO - Running post-action listener: _resource_record_post_action 04:17:55 INFO - Running post-action listener: _start_resource_monitoring 04:17:55 INFO - Starting resource monitoring. 04:17:55 INFO - ##### 04:17:55 INFO - ##### Running install step. 04:17:55 INFO - ##### 04:17:55 INFO - Running pre-action listener: _resource_record_pre_action 04:17:55 INFO - Running main action method: install 04:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:55 INFO - Reading from file tmpfile_stdout 04:17:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:55 INFO - Reading from file tmpfile_stdout 04:17:55 INFO - Output received: 04:17:55 INFO - Usage: mozinstall [options] installer 04:17:55 INFO - Options: 04:17:55 INFO - -h, --help show this help message and exit 04:17:55 INFO - -d DEST, --destination=DEST 04:17:55 INFO - Directory to install application into. [default: 04:17:55 INFO - "/builds/slave/test"] 04:17:55 INFO - --app=APP Application being installed. [default: firefox] 04:17:55 INFO - mkdir: /builds/slave/test/build/application 04:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:18:11 INFO - Reading from file tmpfile_stdout 04:18:11 INFO - Output received: 04:18:11 INFO - /builds/slave/test/build/application/firefox/firefox 04:18:11 INFO - Running post-action listener: _resource_record_post_action 04:18:11 INFO - ##### 04:18:11 INFO - ##### Running run-tests step. 04:18:11 INFO - ##### 04:18:11 INFO - Running pre-action listener: _resource_record_pre_action 04:18:11 INFO - Running main action method: run_tests 04:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:18:11 INFO - Python 2.7.3 04:18:11 INFO - Return code: 0 04:18:11 INFO - grabbing minidump binary from tooltool 04:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2435410>, '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 0x2436310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24367a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:18:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:18:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:18:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:18:11 INFO - Return code: 0 04:18:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:18:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:18:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:18:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:18:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:18:12 INFO - Return code: 0 04:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:18:12 INFO - Using env: {'DISPLAY': ':0', 04:18:12 INFO - 'HOME': '/home/cltbld', 04:18:12 INFO - 'LANG': 'en_US.UTF-8', 04:18:12 INFO - 'LANGUAGE': 'en_US:en', 04:18:12 INFO - 'LOGNAME': 'cltbld', 04:18:12 INFO - 'MAIL': '/var/mail/cltbld', 04:18:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:18:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:12 INFO - 'MOZ_NO_REMOTE': '1', 04:18:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:12 INFO - 'NO_EM_RESTART': '1', 04:18:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:12 INFO - 'PWD': '/builds/slave/test', 04:18:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:18:12 INFO - 'SHELL': '/bin/bash', 04:18:12 INFO - 'SHLVL': '1', 04:18:12 INFO - 'TERM': 'linux', 04:18:12 INFO - 'TMOUT': '86400', 04:18:12 INFO - 'USER': 'cltbld', 04:18:12 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988', 04:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:12 INFO - '_': '/tools/buildbot/bin/python'} 04:18:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:18:12 INFO - mozversion application_buildid: 20160419025852 04:18:12 INFO - mozversion application_changeset: 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 04:18:12 INFO - mozversion application_display_name: Nightly 04:18:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:18:12 INFO - mozversion application_name: Firefox 04:18:12 INFO - mozversion application_remotingname: firefox 04:18:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:18:12 INFO - mozversion application_vendor: Mozilla 04:18:12 INFO - mozversion application_version: 48.0a1 04:18:12 INFO - mozversion platform_buildid: 20160419025852 04:18:12 INFO - mozversion platform_changeset: 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 04:18:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:18:12 INFO - mozversion platform_version: 48.0a1 04:18:12 INFO - using testdate: 1461064692 04:18:12 INFO - actual date: 1461064692 04:18:12 INFO - starting webserver on 'localhost:36150' 04:18:12 INFO - SUITE-START | Running 2 tests 04:18:12 INFO - TEST-START | dromaeo_css 04:18:12 INFO - operating with platform_type : linux_ 04:18:12 INFO - Initialising browser for dromaeo_css test... 04:18:12 INFO - TEST-INFO | started process 27246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbWG3gd/profile http://localhost:36150/getInfo.html) 04:18:17 INFO - PROCESS | 27246 | __metrics Screen width/height:1600/1200 04:18:17 INFO - PROCESS | 27246 | colorDepth:24 04:18:17 INFO - PROCESS | 27246 | Browser inner width/height: 1024/697 04:18:17 INFO - PROCESS | 27246 | __metrics 04:18:18 ERROR - PROCESS | 27246 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:18:19 INFO - TEST-INFO | 27246: exit 0 04:18:19 INFO - Browser initialized. 04:18:19 INFO - Running cycle 1/1 for dromaeo_css test... 04:18:19 INFO - TEST-INFO | started process 27326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbWG3gd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:31 INFO - PROCESS | 27326 | RSS: Main: 154578944 04:18:31 INFO - PROCESS | 27326 | 04:19:22 INFO - PROCESS | 27326 | 1461064762670 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:21:33 INFO - PROCESS | 27326 | Cycle 1(1): loaded http://localhost:36150/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36150/tests/dromaeo/cssquery-ext.html) 04:21:35 INFO - PROCESS | 27326 | RSS: Main: 230711296 04:21:35 INFO - PROCESS | 27326 | 04:24:37 INFO - PROCESS | 27326 | Cycle 1(1): loaded http://localhost:36150/tests/dromaeo/cssquery-ext.html (next: http://localhost:36150/tests/dromaeo/cssquery-jquery.html) 04:24:38 INFO - PROCESS | 27326 | RSS: Main: 237928448 04:24:38 INFO - PROCESS | 27326 | 04:27:39 INFO - PROCESS | 27326 | Cycle 1(1): loaded http://localhost:36150/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36150/tests/dromaeo/cssquery-mootools.html) 04:27:40 INFO - PROCESS | 27326 | RSS: Main: 240959488 04:27:40 INFO - PROCESS | 27326 | 04:30:42 INFO - PROCESS | 27326 | Cycle 1(1): loaded http://localhost:36150/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36150/tests/dromaeo/cssquery-prototype.html) 04:30:43 INFO - PROCESS | 27326 | RSS: Main: 239493120 04:30:43 INFO - PROCESS | 27326 | 04:33:46 INFO - PROCESS | 27326 | Cycle 1(1): loaded http://localhost:36150/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36150/tests/dromaeo/cssquery-yui.html) 04:33:46 INFO - PROCESS | 27326 | RSS: Main: 212754432 04:33:46 INFO - PROCESS | 27326 | 04:36:49 INFO - PROCESS | 27326 | Cycle 1(1): loaded http://localhost:36150/tests/dromaeo/cssquery-yui.html (next: http://localhost:36150/tests/dromaeo/cssquery-dojo.html) 04:36:49 INFO - PROCESS | 27326 | RSS: Main: 259903488 04:36:49 INFO - PROCESS | 27326 | 04:36:49 INFO - PROCESS | 27326 | __start_tp_report 04:36:49 INFO - PROCESS | 27326 | _x_x_mozilla_page_load 04:36:49 INFO - PROCESS | 27326 | _x_x_mozilla_page_load_details 04:36:49 INFO - PROCESS | 27326 | |i|pagename|runs| 04:36:49 INFO - PROCESS | 27326 | |0;dojo.html;2578.316746062294;2644.0745738991345;2675.545157323255;2677.6385187999626;2699.0418401467487;4517.887052823681;4584.770761461922;4591.839285625004;4622.930656040158;4655.674102812804;4607.562281583253;4618.7228766273965;4677.695949763263;4730.455997560273;4742.359781429506;4231.1114665920195;4249.766262855542;4261.3607958806115;4292.871213863589;4401.031773009932;4316.460442444694;4335.6531477481885;4355.1725172217175;4367.3448982652535;4397.450318710161;4171.3325867860995;4180.310248808958;4220.198162349175;4223.64099051581;4287.8284868605215;4266.424032755569;4284.935725964113;4286.5284818669925;4292.205941900727;4330;4271.209826182167;4285.892852678677;4291.849785257501;4312.417823593806;4318.136372725436;4407.867763967086;4479.7088189267915;4496.213162696515;4594.081183763261;4595.724256544618;4945.332380128709;4959.305697202394;4960.925586116175;4962.354893863775;4998.57512111471;4969.130402179604;4977.776000080005;4983.227599722049;4996.325496058022;5038.773255203525;4490.416245888046;4623.606993405531;4708.105459962596;4710.4347478302825;4719.598834099072;5040.57155141817;5058.165402708585;5060.620453466005;5066.544011039025;5109.182530795055;4698.976505117521;4853.830115945925;4856;4857.392825896763;4888.144574699413;4968.726720030433;4973.726445045557;4983.377077865267;5030.84907452777;5030.974845125751;4871.853844384674;4914.533119353656;4922.0648076866;4924.285978533093;4969.726665033458;4751.572358487752;4877.5366340197625;4885.071836351082;4898.877528061756;4948.752562371867;4156.667466602665;4171.311733563928;4176.102138040336;4195.475565554306;4211.810468528924;3640.672339489459;3674.063113905937;3676.6139555346303;3700.130469339703;3717.851285948586;4209;4291.69958102936;4304.7632380218765;4316.352547117957;4339.132173565299;4977.726225057584;4985.052839960396;4999.175136102575;5023.397192336943;5044.495550444926;4332.588404101605;4332.653387728974;4337.414449049338;4345.478542574848;4379.605835474823;4323.567643235651;4446.710963787408;4470.821167153277;4480.32795080734;4495.056038232008;4667.113248482778;4691.882702932454;4692.038132182826;4702.4592171899985;4742.715437073786;4915.041566894564;4941.555260026615;4942.382202224722;4942.950570494249;4990.5508504234795;4557.065801510748;4665.160271151225;4727.456342520654;4794.2089555223;4804.567588917014;4861.683990540603;4885.877853053702;4890.486498917562;4925;4933.038057578881;4904.803807847788;4907.55831975124;4930.506949305184;4950.975245123751;4959.427397970304;4697.224957881911;4806.351142595705;4861.319415281792;4891.5353041461;4905.926411103765;4764.928526072043;4778.068276686013;4786.904261914672;4793.592544633745;4838.129136755418;4709.340692303012;4714.905701885875;4715.693479923794;4728.881777955441;4746.38297021385;4566.543345665407;4788.640851936049;4845.224764037878;4874.2444921037295;4893.21708526634;4743.075100355398;4744.620430365631;4759.833405830779;4763.3807605011125;4808.855734327975 04:36:49 INFO - PROCESS | 27326 | |1;ext.html;581.909803980383;591.243208692873;604.4710877981765;609.9664518451486;630.8202162383722;33750.15624609383;34753.30493390131;34809;34842.8257858711;34961.32906044864;36990.07524811881;37631.4355284671;37659.43510847339;37714.43428348577;37780.43329350062;7544.245575442466;7770.883436748453;7776.3778897688335;7778.299953004229;7778.6888524458955;7595.316421522062;7736;7746.457747957617;7749.806254843646;7752.573608451533;7857;7857.214278572154;7861.135275119732;7873.133955264916;7928.484648497858;7814.3357814585825;7882.054153501559;7891.802704932394;7894.092179399385;7902.130765615778;7682.078150621961;7777.300042996158;7781.455298129134;7782.533048017137;7787.221277872168;35995.64004359949;36387.81806090979;36479.27041459156;36509;36516.45225321622;2983.373491566752;3054.602901622775;3316.369889720945;3418.179636887129;3506.5266189064405;27677.308067298276;28426;28447.71552284471;28841;29240.707592924013;3299.158714527804;3333.1667083229195;3349.732021438279;3387.339468803584;3487.6512348765173;190944;191630;191959.04020479947;192923;193073;32207.35585288281;33167.170820729676;33274.33451331008;51058;51239.487605123475;31029.379412411625;31171;31225.375492490024;31238.68761312403;31264.843675781474;13168.078234523682;13344.799828002588;13348.065635405623;13348.399322030531;13355;9883.555240014217;9886.653967111117;9887.406755594688;9891.554880030415;9943.80112397748;8117.228863258099;8184.836303273901;8184.918150818535;8238.299744521782;8246.3815213858;3131.827749473801;3177.8411079445937;3180.8489920653305;3206.3106432116742;3221;935.4200395754675;953.2945620240972;970.2722957781664;997.9950100249453;1034.8240799064176;27476;27514.724852751617;27790.86104569505;28097.595120243906;28139;993.3493561717087;1013.2856336282903;1046.3303485769113;1060.2631171335847;1115.893990070942;14221.857781422053;14864.256787160815;15006.174660393564;15006.972946951062;15055.096694198164;333030;336885;338683;339769;340013;48184;48948.510514895104;48950.265746013836;49060.754696227006;49259;1028.7222449938624;1183.810590305547;1218.214251807579;1227.613301809945;1239.7644447554935;24577.877110614332;25457.49085018326;25629.871850640626;25705;25741.227763167135;34951.82524087363;35495.82252088723;35534.289314213056;35563.28873422569;35567.28865422729;175169;179234;179356;179736.1013194978;179831;22367.888160559094;24605.87697061503;24807.62788558137;24976.500469990136;25227.243182704548;36122;36403.27193456063;36471.45292820557;36627.816860915525;36939.07652308606;33219.16952076121;33793.49309760307;33795.15512112217;33819.15452113717;34399.14002149966;33168.83415583003;33293.16767080843;33328.854852433324;33569.49645755364;33572;33479.66520334766;33706.157346066546;34290.14274643054;34297.657023430445;34345;27998.040137191016;30684;30690.386192275582;30779.38441231118;30968.070957870397;23137.884310578338;24163;24378.634320484853;24493.632595510724;24523.386915326544 04:36:49 INFO - PROCESS | 27326 | |2;jquery.html;377.89796754876176;382.1706896035602;382.9138443850134;391.1160776644782;396.2965735818923;16121.193940302983;16648.417305394312;16836.07401592912;16842.494725158263;16876.746848797276;15461.912641793355;16240.269187886544;16244;16245.675086498262;16263.186840657949;4647.581717645411;4731.78706958186;4733.92899106512;4775.164346239411;4777.378940737716;3422.931541369171;6220.7822726204595;6823.795286141423;6833.760818371358;6844.828879278033;6748.730050797963;6809.0467334573195;6830.112085428887;6841.247462779091;6846.520743547953;6694.93305066948;6881.793546193622;6882.242953275136;6923.723051077951;6924.995875598035;3833.4058220975794;6104.633721976696;6538.869222615521;6546.93453065468;6549.148610680629;21049.473763156042;21134.471638209016;21761.238356657443;21792.89103554488;22078.448038799157;1976.416956997689;1998.4204580671587;2080.573482436097;2151.698762173297;2394.6408038794148;12747.61757147287;12949.48202071916;13576.45694172232;13874.167549947035;14495.42018319266;1841.815818418161;1858.479625704805;1860.060669361977;1907.3705677126516;2007.718919351292;77248.61375693142;78270.21729782686;78862.6056869712;79065.60467197685;79169;16211;16495.752563711554;17088.914555427393;17166.570835729206;17550.73673894867;29621;29679.477244434464;29954.55068173979;29975.550366744515;30075.44358729489;8873.73378798637;9260.768480788034;9371.718848434557;9492.335536512377;9500.384934561142;7494.925050749532;7603.01160849086;7683.346915512132;7816.296533312029;7817.804554886174;7069.646517674096;7986.600669966595;8215.137410571924;8243.752687419386;8478.406511544255;2786.9212201009614;3057.0523137827345;3175.1903264667826;3330.8501117449773;3335;831.1024093978489;920.7467946314817;943.1464524605243;948.8624149498285;983.0218932162544;16084.597885052734;16899.15504224784;16943.83056169447;17108.572285692957;17224.569385765455;893.8614514750224;915.8122584870085;916.2212119698203;919.9540022998823;972.5234635028785;9379;9435.433873967584;9477.857832132524;9590.712278631652;9709.902900971041;398493;399229;415880;416381;417596;68778.65610671915;71421;74140.62929685316;74496.62751686206;79280.6035969828;951.2247518272586;969.5685419988038;994.5524513968599;997.7505623594102;998.5905778630872;15522.223888805289;15634.843651563793;15649.843501565294;15925.522234332988;16179;30573.694263057976;34968;35071.47392789059;35594.906585742974;35720.82139589285;39747.60252397555;43356.78321608372;44527.77736111299;44636.33045504385;44650.55349446464;7437.590932498548;7438.181800002104;7544.886826697713;7694.4229182810395;7708.730194443392;10986.945065274942;11512.366819824654;11959.162858599815;11974.161808673309;12288.1398302118;10258.384496930208;10333.070023697903;10441.269111162146;10683.839742403714;10836.620718274822;10127.544260508443;10129.64546240878;10440.63457778974;10477.476126193813;10515.684529464128;10509.159267258754;10563.894361056291;10695.518701658288;10820.134389248684;10899.182561307774;7485.88771168422;7752.0697516298405;7778.611069446391;7810.179931107152;7983.281504664608;10009.799804003733;10552.419616921143;10620.734481638021;10651.201159912882;10841.403722795321 04:36:49 INFO - PROCESS | 27326 | |3;mootools.html;1296.4230917241832;1456.1627064437948;1509.5848641623554;1642.6961012212741;1804.3684710351379;7659.234076592338;8118.309943654796;8130.67477300908;8149.266566009058;8151.510909345443;7883.487573307731;7931.127575966639;8036.91963080369;8049.597520124;8053.557054362008;1915.8658893877434;1999.0804230054193;2211.657193135067;2302.3898666853297;2336.9532609347802;2306.6194077977198;2342.1334106380577;2346.296111166652;2346.7066616672914;2350.1421980976907;2256.7630398808137;2257.582347265753;2272.0798076778933;2281.292799232235;2282.805961493275;1854.0914951673717;2137.42289581812;2154.2029449103775;2203.8567493113055;2206.7572567017614;2218.3899427657525;2234.7765223477686;2236.932892013242;2237.69791078204;2251.7410497792634;7617;7660.655270512841;7679.1936846631415;7686.884696729554;7690.15408305086;4567.383403240553;4709.882252943669;4715.858524244278;4726.976365118152;4731.408573928259;2826.9575956360673;2869.8708558114727;2960.2747326904832;2989.9402011959855;3020.6828283030186;938.7653086728318;941.1858742188026;945.2815859946421;957.2581249531669;960.2941837749248;10862.131029517619;10900;10919.836202457049;10927.781444371147;10932.016118549369;4223.767692776927;4265.189613973335;4427.667924905645;4452.888677783017;4486.3494793254795;9277.443353398818;9297.209737172416;9307.674231402003;9311.627534898527;9335.206507446806;4819.2530157825595;4828.855134345975;4838.129136755348;4847.903041939141;4859.271109333557;3681.1349332906743;4164.104717485755;4332.523422423531;4343.979164896246;4345.087531618396;3641.2171383152217;3677.9448308275396;3759.248150369937;3792.544894612664;3828.1386687995537;1258.150748244931;1260.1242136714895;1270.3457719274581;1271.4361335557132;1274.5921305182253;681.9181698196248;731.9935089252278;808.9191080891864;818.337146911004;829.7510746775943;5141.614378921596;5177.042247184283;5182.300389447451;5256.868578285574;5453.182022696627;834.4826207751112;870.8476016697052;872.2847265242567;904.3850181876255;919.8114386550741;3518.4546395308766;3711.109333759878;3742.9625703742613;3745.606711295329;3763.2661630982243;9507.952460237793;9918.950405247928;9961.452120133317;9983.101520863158;10010;9748.245315843216;9910.256730745223;9912.405255684682;9919.40483570988;9924.603015879284;7429.4799364045075;7465.552066876114;7500.474966752384;7519.097708275042;7583.165851756303;5074.898502030012;5118.923216151835;5155.871103222299;5254.632175747661;5271.4464981176425;9046.592903319235;9104.044075372256;9149.817003660022;9204.539773011456;9222.631094756403;8894.288456923301;9323.160915517636;9384.155426011692;9405.05949405054;9464.432134071978;5793.275840519935;6274.403931626488;6440.967795160994;6442.226932768098;6522.184726909137;7575.848483030419;7581.469297149147;7630.4277179212895;7646.885296720442;7656.961715191388;6709.194896612437;6838.897416538656;6869.107016087876;6959.408450281783;6961.825954351182;6701.966490167518;6711.362420570038;6727.495437842083;6787.93212067873;6828.556143850634;6430.710618022294;6529.444997175293;6537.967310163609;6538.248101468392;6573.04690819838;4628.907421851612;4647.977444962103;4710.552497512731;4754.096721623019;4761.999980004238;4580.541945805393;4611.16998940194;4627.814887404466;4672.813087476598;4711.905761884675 04:36:49 INFO - PROCESS | 27326 | |4;prototype.html;312.3035630543887;314.06252336774725;316.2694176452395;319.54305343359005;320.5880443629936;4939.012197560489;4986.601071914247;4995.750212489379;5011.173156429194;5048.469910659378;4897.583705385046;4943.703377797335;4970.254461830718;4970.502949705027;4973.875653108665;3689.0961714379946;3785.9810700946455;3869.2454971280613;3884.9899026253097;3931.095847954972;3887.1448281378052;3897.123147291865;3900.882973510785;3901.551321598024;3918.5689574146822;3628.2017956049626;3863.2273545290914;3863.97604634772;3864.7101467389916;3887.300285948528;3794.4498047783054;3930.329609915774;3930.371140617516;3930.9017274568077;3936.350502167125;3469.9479507807405;3473.6700013498676;3475.565554305712;3479.704225140866;3489.4416893296952;4762.4285085789925;4774.761261936889;4782.354382158399;4787.880302992418;4789.281607758864;4202.6847986400835;4435.778211089432;4452.621527170194;4468.642508599304;4527.275635898241;5161.2516185152945;5207.323048003773;5229.895402091937;5240.240165176028;5242.55438287746;3698.537682789651;3713.9071523211865;3718.609545997658;3719.423489359154;3723.2739615774935;5220.138677118271;5435.483629055233;5472.194175921976;5478.945210547923;5509.614326997112;3744.475773391727;3754.2303827715255;3762.6049264826797;3784.2242340320167;3792.905177370588;3832.2143960488033;3839.865604703822;3843.3082045232127;3846.769193848322;3848.13416981177;4316.014633268669;4402.801873915681;4412.735235885857;4415.668824838086;4416.624586910084;5198.350206224222;5199.740012999335;5210.088234558937;5214.68711877281;5230.660007099526;1307;1327.1638867513404;1332.0675527131048;1334.432866031952;1337.1175024483794;835.8119423129747;880.9383343165916;898.8022635020285;905.4702998745807;911.5806728904778;4562.634989200856;4571.040081582905;4589.770511474413;4609.446866375989;4618.884527886829;5284.154535274338;5301.204819277063;5310.283111779938;5311.150215965427;5332.093544097435;4396.318570621559;4569.223232050559;4571.291449825282;4581.977090114528;4583.427071616048;2828.4343131373807;2842;2844.7724182065385;2855.200543847726;2856.571514272834;5024.7689316117785;5039.3448851649055;5052.267421223902;5057.69653820772;5059.924101138486;5232.3459567554055;5424.647397919122;5425.891482170335;5591.440855914458;5606.187102870061;5141.945901090267;5143.434222235551;5163.057057477277;5166.767495462638;5184.481551844785;5423.7830486780085;5431.891362172813;5432.782688692408;5433.1035379161995;5440.347158341025;5120.129577971679;5270.446603106619;5292.867678308073;5307.65500242483;5307.761150748149;5117.5650069743;5121.8719532012;5145.176771716508;5147.3308469898675;5148.330717006766;3738.794366309879;3756.426847609396;3768.5289338832645;3769.6418840210135;3781.905452363713;5253.737313134252;5346.117890548016;5373.382061062872;5395.433479484597;5408.3509978802795;5197.92203116946;5216.591520289577;5221.451747566451;5229.895402091861;5252.317198764136;5099.51554602327;5193.870153246199;5208.218767184952;5218.55642270396;5223.7910483580235;4924.104219875302;5121;5130.871208334161;5133.8973220534635;5143.92284115746;5047.6214283929585;5213.504717051874;5240.004399164147;5255.132903071103;5265.631405801557;5104.897902041864;5114.130597798308;5120.948790512196;5121.692698438105;5142.331496905378 04:36:49 INFO - PROCESS | 27326 | |5;yui.html;568.4940403041296;599.4425184578344;633.6546582112749;637.3467196123976;669.3875104279583;11178.944105279472;11380.544778208872;11633.302001879883;11789.587364442246;11825.113116516253;12805.423755930982;13214.603561893135;13217.669558261048;13254.204747715145;13274.933625331883;637.8405398650337;809.4900212865915;809.8420807942454;811.2779626132717;814.080089498867;780.7306479264645;784.396015068397;784.7763387434583;789.6643926331315;793.5119901260712;810.8094597769549;812.2689579378548;812.5368539932241;816.0411516468156;850.8383407152652;665.5707068940507;685.3557655803529;804.569555287921;805.0379796143611;843.5023336231623;503.9924401133986;592.4431034827292;592.6829146406652;601.3655593349015;610.6732897899647;11723.824142637868;11735.23720958135;11795.646130616095;11813;11822.881771182265;11245;11266.493007814668;11323.773524529463;12003.3398163101;12023.458944347438;8612.741617751415;8799.384043116985;8813.206811386943;8925.553722313858;9087.818243635156;3199.8880039198516;3216.967830321714;3236.2394837213237;3238.1904523869034;3295.802251864896;45305.77347113243;46020.76989615064;46191.76904115491;46422.30366544505;46522.5347746525;9958.55186516594;9993.15058220045;10002.199824014062;10004.099631033241;10060.798784024279;17011.91494042522;17134.314627414762;17186.398476053528;17359.82640173582;17388.91305543464;6566.507511936624;6574.441172500296;6616.669166541654;6628.304028077079;6699.5310328276555;3585.5876574194303;3656.8171591420323;3699.0382500549513;3744.7378683491893;3810.447485114643;2536.7843733282507;2604.7265037170823;2609.4650596627644;2611.229687242268;2613.294410509152;499.840051183625;502.29427654145985;509.04299916157385;513.0226917721747;514.8558403646985;424.4863714904938;601.9849503762441;632.9303776584572;643.9356064393523;644.1497223664718;7817.022872140982;7958.08482024563;7973.481723687942;8133.129380242577;8173.060098088677;518.8676887393691;553.1868153813887;571.4656795895851;572.4876235769046;576.6799426318433;3833.15670552478;3880.53215340402;3967.1668949520345;3990.341593637075;4028.4964379452567;56274.43725562692;57217.42782572204;58103.418965809804;58174;58210.417895821345;50180.74909625429;50345;50854.93160547147;51031.234531482056;51830.48169518332;40591.7970410152;46318;46731.29903051457;47338.763306183246;47398.763006184745;7914.920850791418;7949.1255961843;8065.637046332812;8241.670333186605;8246.134155913544;23716.407089822893;26757.598636020084;27349.726502734717;27641.861790690917;27649.170524884285;32384.67615323911;33628.32743345168;34690.82654586711;34975;35659.46510802288;10005.949970250102;10221.591136354462;10407.635732749317;10427.322224055715;10834.67495975122;11691.415429228675;11854.110941679237;12001.339926303788;12136.878631213574;12203.816942745689;10590.470476475992;10807.82109543169;10893.618723344645;10974.506147223554;11298.661040168809;7416.925830741624;9116.1339672731;9433.245340372616;10182.949085254526;10429.269951103654;10580.682579522627;10693.786124277316;10785.514651840844;10955.397453140155;11031.558737650405;9224.215941644767;9271;9332.673356432493;9356.391834530734;9852.26108041914;8930.955345223232;9213.677521286723;9345.626174952926;9498.430094194371;9556.61773529051 04:36:49 INFO - PROCESS | 27326 | __end_tp_report 04:36:49 INFO - PROCESS | 27326 | __start_cc_report 04:36:49 INFO - PROCESS | 27326 | _x_x_mozilla_cycle_collect,1086 04:36:49 INFO - PROCESS | 27326 | __end_cc_report 04:36:49 INFO - PROCESS | 27326 | __startTimestamp1461065809679__endTimestamp 04:36:49 INFO - PROCESS | 27326 | 04:36:49 INFO - PROCESS | 27326 | ------- Summary: start ------- 04:36:49 INFO - PROCESS | 27326 | Number of tests: 6 04:36:49 INFO - PROCESS | 27326 | 04:36:49 INFO - PROCESS | 27326 | [#0] dojo.html Cycles:165 Average:4582.57 Median:4714.91 stddev:466.28 (9.9%) stddev-sans-first:440.41 04:36:49 INFO - PROCESS | 27326 | Values: 2578.3 2644.1 2675.5 2677.6 2699.0 4517.9 4584.8 4591.8 4622.9 4655.7 4607.6 4618.7 4677.7 4730.5 4742.4 4231.1 4249.8 4261.4 4292.9 4401.0 4316.5 4335.7 4355.2 4367.3 4397.5 4171.3 4180.3 4220.2 4223.6 4287.8 4266.4 4284.9 4286.5 4292.2 4330.0 4271.2 4285.9 4291.8 4312.4 4318.1 4407.9 4479.7 4496.2 4594.1 4595.7 4945.3 4959.3 4960.9 4962.4 4998.6 4969.1 4977.8 4983.2 4996.3 5038.8 4490.4 4623.6 4708.1 4710.4 4719.6 5040.6 5058.2 5060.6 5066.5 5109.2 4699.0 4853.8 4856.0 4857.4 4888.1 4968.7 4973.7 4983.4 5030.8 5031.0 4871.9 4914.5 4922.1 4924.3 4969.7 4751.6 4877.5 4885.1 4898.9 4948.8 4156.7 4171.3 4176.1 4195.5 4211.8 3640.7 3674.1 3676.6 3700.1 3717.9 4209.0 4291.7 4304.8 4316.4 4339.1 4977.7 4985.1 4999.2 5023.4 5044.5 4332.6 4332.7 4337.4 4345.5 4379.6 4323.6 4446.7 4470.8 4480.3 4495.1 4667.1 4691.9 4692.0 4702.5 4742.7 4915.0 4941.6 4942.4 4943.0 4990.6 4557.1 4665.2 4727.5 4794.2 4804.6 4861.7 4885.9 4890.5 4925.0 4933.0 4904.8 4907.6 4930.5 4951.0 4959.4 4697.2 4806.4 4861.3 4891.5 4905.9 4764.9 4778.1 4786.9 4793.6 4838.1 4709.3 4714.9 4715.7 4728.9 4746.4 4566.5 4788.6 4845.2 4874.2 4893.2 4743.1 4744.6 4759.8 4763.4 4808.9 04:36:49 INFO - PROCESS | 27326 | 04:36:49 INFO - PROCESS | 27326 | [#1] ext.html Cycles:180 Average:38048.26 Median:33794.32 stddev:64938.41 (192.2%) stddev-sans-first:65059.65 04:36:49 INFO - PROCESS | 27326 | Values: 581.9 591.2 604.5 610.0 630.8 33750.2 34753.3 34809.0 34842.8 34961.3 36990.1 37631.4 37659.4 37714.4 37780.4 7544.2 7770.9 7776.4 7778.3 7778.7 7595.3 7736.0 7746.5 7749.8 7752.6 7857.0 7857.2 7861.1 7873.1 7928.5 7814.3 7882.1 7891.8 7894.1 7902.1 7682.1 7777.3 7781.5 7782.5 7787.2 35995.6 36387.8 36479.3 36509.0 36516.5 2983.4 3054.6 3316.4 3418.2 3506.5 27677.3 28426.0 28447.7 28841.0 29240.7 3299.2 3333.2 3349.7 3387.3 3487.7 190944.0 191630.0 191959.0 192923.0 193073.0 32207.4 33167.2 33274.3 51058.0 51239.5 31029.4 31171.0 31225.4 31238.7 31264.8 13168.1 13344.8 13348.1 13348.4 13355.0 9883.6 9886.7 9887.4 9891.6 9943.8 8117.2 8184.8 8184.9 8238.3 8246.4 3131.8 3177.8 3180.8 3206.3 3221.0 935.4 953.3 970.3 998.0 1034.8 27476.0 27514.7 27790.9 28097.6 28139.0 993.3 1013.3 1046.3 1060.3 1115.9 14221.9 14864.3 15006.2 15007.0 15055.1 333030.0 336885.0 338683.0 339769.0 340013.0 48184.0 48948.5 48950.3 49060.8 49259.0 1028.7 1183.8 1218.2 1227.6 1239.8 24577.9 25457.5 25629.9 25705.0 25741.2 34951.8 35495.8 35534.3 35563.3 35567.3 175169.0 179234.0 179356.0 179736.1 179831.0 22367.9 24605.9 24807.6 24976.5 25227.2 36122.0 36403.3 36471.5 36627.8 36939.1 33219.2 33793.5 33795.2 33819.2 34399.1 33168.8 33293.2 33328.9 33569.5 33572.0 33479.7 33706.2 34290.1 34297.7 34345.0 27998.0 30684.0 30690.4 30779.4 30968.1 23137.9 24163.0 24378.6 24493.6 24523.4 04:36:49 INFO - PROCESS | 27326 | 04:36:49 INFO - PROCESS | 27326 | [#2] jquery.html Cycles:180 Average:25862.62 Median:393.71 stddev:67368.11 (17111.3%) stddev-sans-first:67529.92 04:36:49 INFO - PROCESS | 27326 | Values: 377.9 382.2 382.9 391.1 396.3 16121.2 16648.4 16836.1 16842.5 16876.7 15461.9 16240.3 16244.0 16245.7 16263.2 4647.6 4731.8 4733.9 4775.2 4777.4 3422.9 6220.8 6823.8 6833.8 6844.8 6748.7 6809.0 6830.1 6841.2 6846.5 6694.9 6881.8 6882.2 6923.7 6925.0 3833.4 6104.6 6538.9 6546.9 6549.1 21049.5 21134.5 21761.2 21792.9 22078.4 1976.4 1998.4 2080.6 2151.7 2394.6 12747.6 12949.5 13576.5 13874.2 14495.4 1841.8 1858.5 1860.1 1907.4 2007.7 77248.6 78270.2 78862.6 79065.6 79169.0 16211.0 16495.8 17088.9 17166.6 17550.7 29621.0 29679.5 29954.6 29975.6 30075.4 8873.7 9260.8 9371.7 9492.3 9500.4 7494.9 7603.0 7683.3 7816.3 7817.8 7069.6 7986.6 8215.1 8243.8 8478.4 2786.9 3057.1 3175.2 3330.9 3335.0 831.1 920.7 943.1 948.9 983.0 16084.6 16899.2 16943.8 17108.6 17224.6 893.9 915.8 916.2 920.0 972.5 9379.0 9435.4 9477.9 9590.7 9709.9 398493.0 399229.0 415880.0 416381.0 417596.0 68778.7 71421.0 74140.6 74496.6 79280.6 951.2 969.6 994.6 997.8 998.6 15522.2 15634.8 15649.8 15925.5 16179.0 30573.7 34968.0 35071.5 35594.9 35720.8 39747.6 43356.8 44527.8 44636.3 44650.6 7437.6 7438.2 7544.9 7694.4 7708.7 10986.9 11512.4 11959.2 11974.2 12288.1 10258.4 10333.1 10441.3 10683.8 10836.6 10127.5 10129.6 10440.6 10477.5 10515.7 10509.2 10563.9 10695.5 10820.1 10899.2 7485.9 7752.1 7778.6 7810.2 7983.3 10009.8 10552.4 10620.7 10651.2 10841.4 04:36:49 INFO - PROCESS | 27326 | 04:36:49 INFO - PROCESS | 27326 | [#3] mootools.html Cycles:180 Average:5233.03 Median:5179.67 stddev:2937.67 (56.7%) stddev-sans-first:2931.01 04:36:49 INFO - PROCESS | 27326 | Values: 1296.4 1456.2 1509.6 1642.7 1804.4 7659.2 8118.3 8130.7 8149.3 8151.5 7883.5 7931.1 8036.9 8049.6 8053.6 1915.9 1999.1 2211.7 2302.4 2337.0 2306.6 2342.1 2346.3 2346.7 2350.1 2256.8 2257.6 2272.1 2281.3 2282.8 1854.1 2137.4 2154.2 2203.9 2206.8 2218.4 2234.8 2236.9 2237.7 2251.7 7617.0 7660.7 7679.2 7686.9 7690.2 4567.4 4709.9 4715.9 4727.0 4731.4 2827.0 2869.9 2960.3 2989.9 3020.7 938.8 941.2 945.3 957.3 960.3 10862.1 10900.0 10919.8 10927.8 10932.0 4223.8 4265.2 4427.7 4452.9 4486.3 9277.4 9297.2 9307.7 9311.6 9335.2 4819.3 4828.9 4838.1 4847.9 4859.3 3681.1 4164.1 4332.5 4344.0 4345.1 3641.2 3677.9 3759.2 3792.5 3828.1 1258.2 1260.1 1270.3 1271.4 1274.6 681.9 732.0 808.9 818.3 829.8 5141.6 5177.0 5182.3 5256.9 5453.2 834.5 870.8 872.3 904.4 919.8 3518.5 3711.1 3743.0 3745.6 3763.3 9508.0 9919.0 9961.5 9983.1 10010.0 9748.2 9910.3 9912.4 9919.4 9924.6 7429.5 7465.6 7500.5 7519.1 7583.2 5074.9 5118.9 5155.9 5254.6 5271.4 9046.6 9104.0 9149.8 9204.5 9222.6 8894.3 9323.2 9384.2 9405.1 9464.4 5793.3 6274.4 6441.0 6442.2 6522.2 7575.8 7581.5 7630.4 7646.9 7657.0 6709.2 6838.9 6869.1 6959.4 6961.8 6702.0 6711.4 6727.5 6787.9 6828.6 6430.7 6529.4 6538.0 6538.2 6573.0 4628.9 4648.0 4710.6 4754.1 4762.0 4580.5 4611.2 4627.8 4672.8 4711.9 04:36:49 INFO - PROCESS | 27326 | 04:36:49 INFO - PROCESS | 27326 | [#4] prototype.html Cycles:180 Average:4330.58 Median:4972.19 stddev:1259.15 (25.3%) stddev-sans-first:1226.03 04:36:49 INFO - PROCESS | 27326 | Values: 312.3 314.1 316.3 319.5 320.6 4939.0 4986.6 4995.8 5011.2 5048.5 4897.6 4943.7 4970.3 4970.5 4973.9 3689.1 3786.0 3869.2 3885.0 3931.1 3887.1 3897.1 3900.9 3901.6 3918.6 3628.2 3863.2 3864.0 3864.7 3887.3 3794.4 3930.3 3930.4 3930.9 3936.4 3469.9 3473.7 3475.6 3479.7 3489.4 4762.4 4774.8 4782.4 4787.9 4789.3 4202.7 4435.8 4452.6 4468.6 4527.3 5161.3 5207.3 5229.9 5240.2 5242.6 3698.5 3713.9 3718.6 3719.4 3723.3 5220.1 5435.5 5472.2 5478.9 5509.6 3744.5 3754.2 3762.6 3784.2 3792.9 3832.2 3839.9 3843.3 3846.8 3848.1 4316.0 4402.8 4412.7 4415.7 4416.6 5198.4 5199.7 5210.1 5214.7 5230.7 1307.0 1327.2 1332.1 1334.4 1337.1 835.8 880.9 898.8 905.5 911.6 4562.6 4571.0 4589.8 4609.4 4618.9 5284.2 5301.2 5310.3 5311.2 5332.1 4396.3 4569.2 4571.3 4582.0 4583.4 2828.4 2842.0 2844.8 2855.2 2856.6 5024.8 5039.3 5052.3 5057.7 5059.9 5232.3 5424.6 5425.9 5591.4 5606.2 5141.9 5143.4 5163.1 5166.8 5184.5 5423.8 5431.9 5432.8 5433.1 5440.3 5120.1 5270.4 5292.9 5307.7 5307.8 5117.6 5121.9 5145.2 5147.3 5148.3 3738.8 3756.4 3768.5 3769.6 3781.9 5253.7 5346.1 5373.4 5395.4 5408.4 5197.9 5216.6 5221.5 5229.9 5252.3 5099.5 5193.9 5208.2 5218.6 5223.8 4924.1 5121.0 5130.9 5133.9 5143.9 5047.6 5213.5 5240.0 5255.1 5265.6 5104.9 5114.1 5120.9 5121.7 5142.3 04:36:49 INFO - PROCESS | 27326 | 04:36:49 INFO - PROCESS | 27326 | [#5] yui.html Cycles:180 Average:12764.82 Median:23949.30 stddev:15107.49 (63.1%) stddev-sans-first:15122.11 04:36:49 INFO - PROCESS | 27326 | Values: 568.5 599.4 633.7 637.3 669.4 11178.9 11380.5 11633.3 11789.6 11825.1 12805.4 13214.6 13217.7 13254.2 13274.9 637.8 809.5 809.8 811.3 814.1 780.7 784.4 784.8 789.7 793.5 810.8 812.3 812.5 816.0 850.8 665.6 685.4 804.6 805.0 843.5 504.0 592.4 592.7 601.4 610.7 11723.8 11735.2 11795.6 11813.0 11822.9 11245.0 11266.5 11323.8 12003.3 12023.5 8612.7 8799.4 8813.2 8925.6 9087.8 3199.9 3217.0 3236.2 3238.2 3295.8 45305.8 46020.8 46191.8 46422.3 46522.5 9958.6 9993.2 10002.2 10004.1 10060.8 17011.9 17134.3 17186.4 17359.8 17388.9 6566.5 6574.4 6616.7 6628.3 6699.5 3585.6 3656.8 3699.0 3744.7 3810.4 2536.8 2604.7 2609.5 2611.2 2613.3 499.8 502.3 509.0 513.0 514.9 424.5 602.0 632.9 643.9 644.1 7817.0 7958.1 7973.5 8133.1 8173.1 518.9 553.2 571.5 572.5 576.7 3833.2 3880.5 3967.2 3990.3 4028.5 56274.4 57217.4 58103.4 58174.0 58210.4 50180.7 50345.0 50854.9 51031.2 51830.5 40591.8 46318.0 46731.3 47338.8 47398.8 7914.9 7949.1 8065.6 8241.7 8246.1 23716.4 26757.6 27349.7 27641.9 27649.2 32384.7 33628.3 34690.8 34975.0 35659.5 10005.9 10221.6 10407.6 10427.3 10834.7 11691.4 11854.1 12001.3 12136.9 12203.8 10590.5 10807.8 10893.6 10974.5 11298.7 7416.9 9116.1 9433.2 10182.9 10429.3 10580.7 10693.8 10785.5 10955.4 11031.6 9224.2 9271.0 9332.7 9356.4 9852.3 8931.0 9213.7 9345.6 9498.4 9556.6 04:36:49 INFO - PROCESS | 27326 | -------- Summary: end -------- 04:36:49 INFO - PROCESS | 27326 | 04:36:50 INFO - TEST-INFO | 27326: exit 0 04:36:50 INFO - TEST-OK | dromaeo_css | took 1117667ms 04:36:50 INFO - TEST-START | kraken 04:36:50 INFO - operating with platform_type : linux_ 04:36:50 INFO - Initialising browser for kraken test... 04:36:50 INFO - TEST-INFO | started process 27502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpckBGhr/profile http://localhost:36150/getInfo.html) 04:36:54 INFO - PROCESS | 27502 | __metrics Screen width/height:1600/1200 04:36:54 INFO - PROCESS | 27502 | colorDepth:24 04:36:54 INFO - PROCESS | 27502 | Browser inner width/height: 1024/697 04:36:54 INFO - PROCESS | 27502 | __metrics 04:36:55 ERROR - PROCESS | 27502 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:36:56 INFO - TEST-INFO | 27502: exit 0 04:36:56 INFO - Browser initialized. 04:36:56 INFO - Running cycle 1/1 for kraken test... 04:36:56 INFO - TEST-INFO | started process 27582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpckBGhr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:08 INFO - PROCESS | 27582 | RSS: Main: 154767360 04:37:08 INFO - PROCESS | 27582 | 04:37:11 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36150/tests/kraken/driver.html?testName=audio-beat-detection) 04:37:12 INFO - PROCESS | 27582 | RSS: Main: 209252352 04:37:12 INFO - PROCESS | 27582 | 04:37:14 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36150/tests/kraken/driver.html?testName=audio-dft) 04:37:15 INFO - PROCESS | 27582 | RSS: Main: 194646016 04:37:15 INFO - PROCESS | 27582 | 04:37:18 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36150/tests/kraken/driver.html?testName=audio-fft) 04:37:19 INFO - PROCESS | 27582 | RSS: Main: 266055680 04:37:19 INFO - PROCESS | 27582 | 04:37:21 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36150/tests/kraken/driver.html?testName=audio-oscillator) 04:37:22 INFO - PROCESS | 27582 | RSS: Main: 173985792 04:37:22 INFO - PROCESS | 27582 | 04:37:24 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36150/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:37:24 INFO - PROCESS | 27582 | RSS: Main: 178331648 04:37:24 INFO - PROCESS | 27582 | 04:37:28 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36150/tests/kraken/driver.html?testName=imaging-darkroom) 04:37:28 INFO - PROCESS | 27582 | RSS: Main: 213938176 04:37:28 INFO - PROCESS | 27582 | 04:37:32 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36150/tests/kraken/driver.html?testName=imaging-desaturate) 04:37:32 INFO - PROCESS | 27582 | RSS: Main: 212025344 04:37:32 INFO - PROCESS | 27582 | 04:37:35 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36150/tests/kraken/driver.html?testName=json-parse-financial) 04:37:36 INFO - PROCESS | 27582 | RSS: Main: 213291008 04:37:36 INFO - PROCESS | 27582 | 04:37:38 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36150/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:37:38 INFO - PROCESS | 27582 | RSS: Main: 201986048 04:37:38 INFO - PROCESS | 27582 | 04:37:40 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36150/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:37:41 INFO - PROCESS | 27582 | RSS: Main: 205348864 04:37:41 INFO - PROCESS | 27582 | 04:37:43 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36150/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:37:43 INFO - PROCESS | 27582 | RSS: Main: 218169344 04:37:43 INFO - PROCESS | 27582 | 04:37:46 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:47 INFO - PROCESS | 27582 | RSS: Main: 223174656 04:37:47 INFO - PROCESS | 27582 | 04:37:50 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:50 INFO - PROCESS | 27582 | RSS: Main: 217894912 04:37:50 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | Cycle 1(1): loaded http://localhost:36150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36150/tests/kraken/driver.html?testName=ai-astar) 04:37:52 INFO - PROCESS | 27582 | RSS: Main: 280715264 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | __start_tp_report 04:37:52 INFO - PROCESS | 27582 | _x_x_mozilla_page_load 04:37:52 INFO - PROCESS | 27582 | _x_x_mozilla_page_load_details 04:37:52 INFO - PROCESS | 27582 | |i|pagename|runs| 04:37:52 INFO - PROCESS | 27582 | |0;ai-astar;111;114;107;113;112;113;102;113;113;113 04:37:52 INFO - PROCESS | 27582 | |1;audio-beat-detection;158;132;164;193;132;162;157;141;188;134 04:37:52 INFO - PROCESS | 27582 | |2;audio-dft;163;163;164;164;162;160;160;161;161;162 04:37:52 INFO - PROCESS | 27582 | |3;audio-fft;78;76;110;114;78;74;76;116;98;73 04:37:52 INFO - PROCESS | 27582 | |4;audio-oscillator;95;95;143;94;96;95;141;95;95;144 04:37:52 INFO - PROCESS | 27582 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 04:37:52 INFO - PROCESS | 27582 | |6;imaging-darkroom;146;146;146;146;145;145;146;146;146;146 04:37:52 INFO - PROCESS | 27582 | |7;imaging-desaturate;94;95;94;95;94;95;94;95;95;95 04:37:52 INFO - PROCESS | 27582 | |8;json-parse-financial;64;66;64;65;67;65;66;81;63;62 04:37:52 INFO - PROCESS | 27582 | |9;json-stringify-tinderbox;65;65;66;65;65;70;64;66;65;66 04:37:52 INFO - PROCESS | 27582 | |10;stanford-crypto-aes;79;79;78;78;85;79;79;78;80;79 04:37:52 INFO - PROCESS | 27582 | |11;stanford-crypto-ccm;138;135;132;142;132;131;133;133;166;158 04:37:52 INFO - PROCESS | 27582 | |12;stanford-crypto-pbkdf2;178;182;178;178;175;173;177;173;173;177 04:37:52 INFO - PROCESS | 27582 | |13;stanford-crypto-sha256-iterative;76;74;73;73;74;72;72;72;73;73 04:37:52 INFO - PROCESS | 27582 | __end_tp_report 04:37:52 INFO - PROCESS | 27582 | __start_cc_report 04:37:52 INFO - PROCESS | 27582 | _x_x_mozilla_cycle_collect,1875 04:37:52 INFO - PROCESS | 27582 | __end_cc_report 04:37:52 INFO - PROCESS | 27582 | __startTimestamp1461065872956__endTimestamp 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | ------- Summary: start ------- 04:37:52 INFO - PROCESS | 27582 | Number of tests: 14 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:3.98 04:37:52 INFO - PROCESS | 27582 | Values: 111.0 114.0 107.0 113.0 112.0 113.0 102.0 113.0 113.0 113.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:160.00 stddev:22.01 (13.8%) stddev-sans-first:23.33 04:37:52 INFO - PROCESS | 27582 | Values: 158.0 132.0 164.0 193.0 132.0 162.0 157.0 141.0 188.0 134.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.49 (0.9%) stddev-sans-first:1.54 04:37:52 INFO - PROCESS | 27582 | Values: 163.0 163.0 164.0 164.0 162.0 160.0 160.0 161.0 161.0 162.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#3] audio-fft Cycles:10 Average:89.30 Median:76.00 stddev:18.06 (23.8%) stddev-sans-first:18.69 04:37:52 INFO - PROCESS | 27582 | Values: 78.0 76.0 110.0 114.0 78.0 74.0 76.0 116.0 98.0 73.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:95.00 stddev:23.04 (24.3%) stddev-sans-first:23.85 04:37:52 INFO - PROCESS | 27582 | Values: 95.0 95.0 143.0 94.0 96.0 95.0 141.0 95.0 95.0 144.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:37:52 INFO - PROCESS | 27582 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:37:52 INFO - PROCESS | 27582 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:37:52 INFO - PROCESS | 27582 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.50 stddev:5.38 (8.2%) stddev-sans-first:5.64 04:37:52 INFO - PROCESS | 27582 | Values: 64.0 66.0 64.0 65.0 67.0 65.0 66.0 81.0 63.0 62.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.64 (2.5%) stddev-sans-first:1.72 04:37:52 INFO - PROCESS | 27582 | Values: 65.0 65.0 66.0 65.0 65.0 70.0 64.0 66.0 65.0 66.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.07 (2.6%) stddev-sans-first:2.19 04:37:52 INFO - PROCESS | 27582 | Values: 79.0 79.0 78.0 78.0 85.0 79.0 79.0 78.0 80.0 79.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:136.50 stddev:12.20 (8.9%) stddev-sans-first:12.92 04:37:52 INFO - PROCESS | 27582 | Values: 138.0 135.0 132.0 142.0 132.0 131.0 133.0 133.0 166.0 158.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:177.50 stddev:2.91 (1.6%) stddev-sans-first:3.03 04:37:52 INFO - PROCESS | 27582 | Values: 178.0 182.0 178.0 178.0 175.0 173.0 177.0 173.0 173.0 177.0 04:37:52 INFO - PROCESS | 27582 | 04:37:52 INFO - PROCESS | 27582 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:1.23 (1.7%) stddev-sans-first:0.78 04:37:52 INFO - PROCESS | 27582 | Values: 76.0 74.0 73.0 73.0 74.0 72.0 72.0 72.0 73.0 73.0 04:37:52 INFO - PROCESS | 27582 | -------- Summary: end -------- 04:37:52 INFO - PROCESS | 27582 | 04:37:53 INFO - TEST-INFO | 27582: exit 0 04:37:54 INFO - TEST-OK | kraken | took 63536ms 04:37:54 INFO - SUITE-END | took 1181s 04:37:54 INFO - Completed test suite (00:19:41) 04:37:54 INFO - javascript benchmark 04:37:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.316746062294, 2644.0745738991345, 2675.545157323255, 2677.6385187999626, 2699.0418401467487, 4517.887052823681, 4584.770761461922, 4591.839285625004, 4622.930656040158, 4655.674102812804, 4607.562281583253, 4618.7228766273965, 4677.695949763263, 4730.455997560273, 4742.359781429506, 4231.1114665920195, 4249.766262855542, 4261.3607958806115, 4292.871213863589, 4401.031773009932, 4316.460442444694, 4335.6531477481885, 4355.1725172217175, 4367.3448982652535, 4397.450318710161, 4171.3325867860995, 4180.310248808958, 4220.198162349175, 4223.64099051581, 4287.8284868605215, 4266.424032755569, 4284.935725964113, 4286.5284818669925, 4292.205941900727, 4330.0, 4271.209826182167, 4285.892852678677, 4291.849785257501, 4312.417823593806, 4318.136372725436, 4407.867763967086, 4479.7088189267915, 4496.213162696515, 4594.081183763261, 4595.724256544618, 4945.332380128709, 4959.305697202394, 4960.925586116175, 4962.354893863775, 4998.57512111471, 4969.130402179604, 4977.776000080005, 4983.227599722049, 4996.325496058022, 5038.773255203525, 4490.416245888046, 4623.606993405531, 4708.105459962596, 4710.4347478302825, 4719.598834099072, 5040.57155141817, 5058.165402708585, 5060.620453466005, 5066.544011039025, 5109.182530795055, 4698.976505117521, 4853.830115945925, 4856.0, 4857.392825896763, 4888.144574699413, 4968.726720030433, 4973.726445045557, 4983.377077865267, 5030.84907452777, 5030.974845125751, 4871.853844384674, 4914.533119353656, 4922.0648076866, 4924.285978533093, 4969.726665033458, 4751.572358487752, 4877.5366340197625, 4885.071836351082, 4898.877528061756, 4948.752562371867, 4156.667466602665, 4171.311733563928, 4176.102138040336, 4195.475565554306, 4211.810468528924, 3640.672339489459, 3674.063113905937, 3676.6139555346303, 3700.130469339703, 3717.851285948586, 4209.0, 4291.69958102936, 4304.7632380218765, 4316.352547117957, 4339.132173565299, 4977.726225057584, 4985.052839960396, 4999.175136102575, 5023.397192336943, 5044.495550444926, 4332.588404101605, 4332.653387728974, 4337.414449049338, 4345.478542574848, 4379.605835474823, 4323.567643235651, 4446.710963787408, 4470.821167153277, 4480.32795080734, 4495.056038232008, 4667.113248482778, 4691.882702932454, 4692.038132182826, 4702.4592171899985, 4742.715437073786, 4915.041566894564, 4941.555260026615, 4942.382202224722, 4942.950570494249, 4990.5508504234795, 4557.065801510748, 4665.160271151225, 4727.456342520654, 4794.2089555223, 4804.567588917014, 4861.683990540603, 4885.877853053702, 4890.486498917562, 4925.0, 4933.038057578881, 4904.803807847788, 4907.55831975124, 4930.506949305184, 4950.975245123751, 4959.427397970304, 4697.224957881911, 4806.351142595705, 4861.319415281792, 4891.5353041461, 4905.926411103765, 4764.928526072043, 4778.068276686013, 4786.904261914672, 4793.592544633745, 4838.129136755418, 4709.340692303012, 4714.905701885875, 4715.693479923794, 4728.881777955441, 4746.38297021385, 4566.543345665407, 4788.640851936049, 4845.224764037878, 4874.2444921037295, 4893.21708526634, 4743.075100355398, 4744.620430365631, 4759.833405830779, 4763.3807605011125, 4808.855734327975], "value": 4553.996831457909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.909803980383, 591.243208692873, 604.4710877981765, 609.9664518451486, 630.8202162383722, 33750.15624609383, 34753.30493390131, 34809.0, 34842.8257858711, 34961.32906044864, 36990.07524811881, 37631.4355284671, 37659.43510847339, 37714.43428348577, 37780.43329350062, 7544.245575442466, 7770.883436748453, 7776.3778897688335, 7778.299953004229, 7778.6888524458955, 7595.316421522062, 7736.0, 7746.457747957617, 7749.806254843646, 7752.573608451533, 7857.0, 7857.214278572154, 7861.135275119732, 7873.133955264916, 7928.484648497858, 7814.3357814585825, 7882.054153501559, 7891.802704932394, 7894.092179399385, 7902.130765615778, 7682.078150621961, 7777.300042996158, 7781.455298129134, 7782.533048017137, 7787.221277872168, 35995.64004359949, 36387.81806090979, 36479.27041459156, 36509.0, 36516.45225321622, 2983.373491566752, 3054.602901622775, 3316.369889720945, 3418.179636887129, 3506.5266189064405, 27677.308067298276, 28426.0, 28447.71552284471, 28841.0, 29240.707592924013, 3299.158714527804, 3333.1667083229195, 3349.732021438279, 3387.339468803584, 3487.6512348765173, 190944.0, 191630.0, 191959.04020479947, 192923.0, 193073.0, 32207.35585288281, 33167.170820729676, 33274.33451331008, 51058.0, 51239.487605123475, 31029.379412411625, 31171.0, 31225.375492490024, 31238.68761312403, 31264.843675781474, 13168.078234523682, 13344.799828002588, 13348.065635405623, 13348.399322030531, 13355.0, 9883.555240014217, 9886.653967111117, 9887.406755594688, 9891.554880030415, 9943.80112397748, 8117.228863258099, 8184.836303273901, 8184.918150818535, 8238.299744521782, 8246.3815213858, 3131.827749473801, 3177.8411079445937, 3180.8489920653305, 3206.3106432116742, 3221.0, 935.4200395754675, 953.2945620240972, 970.2722957781664, 997.9950100249453, 1034.8240799064176, 27476.0, 27514.724852751617, 27790.86104569505, 28097.595120243906, 28139.0, 993.3493561717087, 1013.2856336282903, 1046.3303485769113, 1060.2631171335847, 1115.893990070942, 14221.857781422053, 14864.256787160815, 15006.174660393564, 15006.972946951062, 15055.096694198164, 333030.0, 336885.0, 338683.0, 339769.0, 340013.0, 48184.0, 48948.510514895104, 48950.265746013836, 49060.754696227006, 49259.0, 1028.7222449938624, 1183.810590305547, 1218.214251807579, 1227.613301809945, 1239.7644447554935, 24577.877110614332, 25457.49085018326, 25629.871850640626, 25705.0, 25741.227763167135, 34951.82524087363, 35495.82252088723, 35534.289314213056, 35563.28873422569, 35567.28865422729, 175169.0, 179234.0, 179356.0, 179736.1013194978, 179831.0, 22367.888160559094, 24605.87697061503, 24807.62788558137, 24976.500469990136, 25227.243182704548, 36122.0, 36403.27193456063, 36471.45292820557, 36627.816860915525, 36939.07652308606, 33219.16952076121, 33793.49309760307, 33795.15512112217, 33819.15452113717, 34399.14002149966, 33168.83415583003, 33293.16767080843, 33328.854852433324, 33569.49645755364, 33572.0, 33479.66520334766, 33706.157346066546, 34290.14274643054, 34297.657023430445, 34345.0, 27998.040137191016, 30684.0, 30690.386192275582, 30779.38441231118, 30968.070957870397, 23137.884310578338, 24163.0, 24378.634320484853, 24493.632595510724, 24523.386915326544], "value": 15495.883552399739, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.89796754876176, 382.1706896035602, 382.9138443850134, 391.1160776644782, 396.2965735818923, 16121.193940302983, 16648.417305394312, 16836.07401592912, 16842.494725158263, 16876.746848797276, 15461.912641793355, 16240.269187886544, 16244.0, 16245.675086498262, 16263.186840657949, 4647.581717645411, 4731.78706958186, 4733.92899106512, 4775.164346239411, 4777.378940737716, 3422.931541369171, 6220.7822726204595, 6823.795286141423, 6833.760818371358, 6844.828879278033, 6748.730050797963, 6809.0467334573195, 6830.112085428887, 6841.247462779091, 6846.520743547953, 6694.93305066948, 6881.793546193622, 6882.242953275136, 6923.723051077951, 6924.995875598035, 3833.4058220975794, 6104.633721976696, 6538.869222615521, 6546.93453065468, 6549.148610680629, 21049.473763156042, 21134.471638209016, 21761.238356657443, 21792.89103554488, 22078.448038799157, 1976.416956997689, 1998.4204580671587, 2080.573482436097, 2151.698762173297, 2394.6408038794148, 12747.61757147287, 12949.48202071916, 13576.45694172232, 13874.167549947035, 14495.42018319266, 1841.815818418161, 1858.479625704805, 1860.060669361977, 1907.3705677126516, 2007.718919351292, 77248.61375693142, 78270.21729782686, 78862.6056869712, 79065.60467197685, 79169.0, 16211.0, 16495.752563711554, 17088.914555427393, 17166.570835729206, 17550.73673894867, 29621.0, 29679.477244434464, 29954.55068173979, 29975.550366744515, 30075.44358729489, 8873.73378798637, 9260.768480788034, 9371.718848434557, 9492.335536512377, 9500.384934561142, 7494.925050749532, 7603.01160849086, 7683.346915512132, 7816.296533312029, 7817.804554886174, 7069.646517674096, 7986.600669966595, 8215.137410571924, 8243.752687419386, 8478.406511544255, 2786.9212201009614, 3057.0523137827345, 3175.1903264667826, 3330.8501117449773, 3335.0, 831.1024093978489, 920.7467946314817, 943.1464524605243, 948.8624149498285, 983.0218932162544, 16084.597885052734, 16899.15504224784, 16943.83056169447, 17108.572285692957, 17224.569385765455, 893.8614514750224, 915.8122584870085, 916.2212119698203, 919.9540022998823, 972.5234635028785, 9379.0, 9435.433873967584, 9477.857832132524, 9590.712278631652, 9709.902900971041, 398493.0, 399229.0, 415880.0, 416381.0, 417596.0, 68778.65610671915, 71421.0, 74140.62929685316, 74496.62751686206, 79280.6035969828, 951.2247518272586, 969.5685419988038, 994.5524513968599, 997.7505623594102, 998.5905778630872, 15522.223888805289, 15634.843651563793, 15649.843501565294, 15925.522234332988, 16179.0, 30573.694263057976, 34968.0, 35071.47392789059, 35594.906585742974, 35720.82139589285, 39747.60252397555, 43356.78321608372, 44527.77736111299, 44636.33045504385, 44650.55349446464, 7437.590932498548, 7438.181800002104, 7544.886826697713, 7694.4229182810395, 7708.730194443392, 10986.945065274942, 11512.366819824654, 11959.162858599815, 11974.161808673309, 12288.1398302118, 10258.384496930208, 10333.070023697903, 10441.269111162146, 10683.839742403714, 10836.620718274822, 10127.544260508443, 10129.64546240878, 10440.63457778974, 10477.476126193813, 10515.684529464128, 10509.159267258754, 10563.894361056291, 10695.518701658288, 10820.134389248684, 10899.182561307774, 7485.88771168422, 7752.0697516298405, 7778.611069446391, 7810.179931107152, 7983.281504664608, 10009.799804003733, 10552.419616921143, 10620.734481638021, 10651.201159912882, 10841.403722795321], "value": 9227.180108633007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.4230917241832, 1456.1627064437948, 1509.5848641623554, 1642.6961012212741, 1804.3684710351379, 7659.234076592338, 8118.309943654796, 8130.67477300908, 8149.266566009058, 8151.510909345443, 7883.487573307731, 7931.127575966639, 8036.91963080369, 8049.597520124, 8053.557054362008, 1915.8658893877434, 1999.0804230054193, 2211.657193135067, 2302.3898666853297, 2336.9532609347802, 2306.6194077977198, 2342.1334106380577, 2346.296111166652, 2346.7066616672914, 2350.1421980976907, 2256.7630398808137, 2257.582347265753, 2272.0798076778933, 2281.292799232235, 2282.805961493275, 1854.0914951673717, 2137.42289581812, 2154.2029449103775, 2203.8567493113055, 2206.7572567017614, 2218.3899427657525, 2234.7765223477686, 2236.932892013242, 2237.69791078204, 2251.7410497792634, 7617.0, 7660.655270512841, 7679.1936846631415, 7686.884696729554, 7690.15408305086, 4567.383403240553, 4709.882252943669, 4715.858524244278, 4726.976365118152, 4731.408573928259, 2826.9575956360673, 2869.8708558114727, 2960.2747326904832, 2989.9402011959855, 3020.6828283030186, 938.7653086728318, 941.1858742188026, 945.2815859946421, 957.2581249531669, 960.2941837749248, 10862.131029517619, 10900.0, 10919.836202457049, 10927.781444371147, 10932.016118549369, 4223.767692776927, 4265.189613973335, 4427.667924905645, 4452.888677783017, 4486.3494793254795, 9277.443353398818, 9297.209737172416, 9307.674231402003, 9311.627534898527, 9335.206507446806, 4819.2530157825595, 4828.855134345975, 4838.129136755348, 4847.903041939141, 4859.271109333557, 3681.1349332906743, 4164.104717485755, 4332.523422423531, 4343.979164896246, 4345.087531618396, 3641.2171383152217, 3677.9448308275396, 3759.248150369937, 3792.544894612664, 3828.1386687995537, 1258.150748244931, 1260.1242136714895, 1270.3457719274581, 1271.4361335557132, 1274.5921305182253, 681.9181698196248, 731.9935089252278, 808.9191080891864, 818.337146911004, 829.7510746775943, 5141.614378921596, 5177.042247184283, 5182.300389447451, 5256.868578285574, 5453.182022696627, 834.4826207751112, 870.8476016697052, 872.2847265242567, 904.3850181876255, 919.8114386550741, 3518.4546395308766, 3711.109333759878, 3742.9625703742613, 3745.606711295329, 3763.2661630982243, 9507.952460237793, 9918.950405247928, 9961.452120133317, 9983.101520863158, 10010.0, 9748.245315843216, 9910.256730745223, 9912.405255684682, 9919.40483570988, 9924.603015879284, 7429.4799364045075, 7465.552066876114, 7500.474966752384, 7519.097708275042, 7583.165851756303, 5074.898502030012, 5118.923216151835, 5155.871103222299, 5254.632175747661, 5271.4464981176425, 9046.592903319235, 9104.044075372256, 9149.817003660022, 9204.539773011456, 9222.631094756403, 8894.288456923301, 9323.160915517636, 9384.155426011692, 9405.05949405054, 9464.432134071978, 5793.275840519935, 6274.403931626488, 6440.967795160994, 6442.226932768098, 6522.184726909137, 7575.848483030419, 7581.469297149147, 7630.4277179212895, 7646.885296720442, 7656.961715191388, 6709.194896612437, 6838.897416538656, 6869.107016087876, 6959.408450281783, 6961.825954351182, 6701.966490167518, 6711.362420570038, 6727.495437842083, 6787.93212067873, 6828.556143850634, 6430.710618022294, 6529.444997175293, 6537.967310163609, 6538.248101468392, 6573.04690819838, 4628.907421851612, 4647.977444962103, 4710.552497512731, 4754.096721623019, 4761.999980004238, 4580.541945805393, 4611.16998940194, 4627.814887404466, 4672.813087476598, 4711.905761884675], "value": 4213.293815648749, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.3035630543887, 314.06252336774725, 316.2694176452395, 319.54305343359005, 320.5880443629936, 4939.012197560489, 4986.601071914247, 4995.750212489379, 5011.173156429194, 5048.469910659378, 4897.583705385046, 4943.703377797335, 4970.254461830718, 4970.502949705027, 4973.875653108665, 3689.0961714379946, 3785.9810700946455, 3869.2454971280613, 3884.9899026253097, 3931.095847954972, 3887.1448281378052, 3897.123147291865, 3900.882973510785, 3901.551321598024, 3918.5689574146822, 3628.2017956049626, 3863.2273545290914, 3863.97604634772, 3864.7101467389916, 3887.300285948528, 3794.4498047783054, 3930.329609915774, 3930.371140617516, 3930.9017274568077, 3936.350502167125, 3469.9479507807405, 3473.6700013498676, 3475.565554305712, 3479.704225140866, 3489.4416893296952, 4762.4285085789925, 4774.761261936889, 4782.354382158399, 4787.880302992418, 4789.281607758864, 4202.6847986400835, 4435.778211089432, 4452.621527170194, 4468.642508599304, 4527.275635898241, 5161.2516185152945, 5207.323048003773, 5229.895402091937, 5240.240165176028, 5242.55438287746, 3698.537682789651, 3713.9071523211865, 3718.609545997658, 3719.423489359154, 3723.2739615774935, 5220.138677118271, 5435.483629055233, 5472.194175921976, 5478.945210547923, 5509.614326997112, 3744.475773391727, 3754.2303827715255, 3762.6049264826797, 3784.2242340320167, 3792.905177370588, 3832.2143960488033, 3839.865604703822, 3843.3082045232127, 3846.769193848322, 3848.13416981177, 4316.014633268669, 4402.801873915681, 4412.735235885857, 4415.668824838086, 4416.624586910084, 5198.350206224222, 5199.740012999335, 5210.088234558937, 5214.68711877281, 5230.660007099526, 1307.0, 1327.1638867513404, 1332.0675527131048, 1334.432866031952, 1337.1175024483794, 835.8119423129747, 880.9383343165916, 898.8022635020285, 905.4702998745807, 911.5806728904778, 4562.634989200856, 4571.040081582905, 4589.770511474413, 4609.446866375989, 4618.884527886829, 5284.154535274338, 5301.204819277063, 5310.283111779938, 5311.150215965427, 5332.093544097435, 4396.318570621559, 4569.223232050559, 4571.291449825282, 4581.977090114528, 4583.427071616048, 2828.4343131373807, 2842.0, 2844.7724182065385, 2855.200543847726, 2856.571514272834, 5024.7689316117785, 5039.3448851649055, 5052.267421223902, 5057.69653820772, 5059.924101138486, 5232.3459567554055, 5424.647397919122, 5425.891482170335, 5591.440855914458, 5606.187102870061, 5141.945901090267, 5143.434222235551, 5163.057057477277, 5166.767495462638, 5184.481551844785, 5423.7830486780085, 5431.891362172813, 5432.782688692408, 5433.1035379161995, 5440.347158341025, 5120.129577971679, 5270.446603106619, 5292.867678308073, 5307.65500242483, 5307.761150748149, 5117.5650069743, 5121.8719532012, 5145.176771716508, 5147.3308469898675, 5148.330717006766, 3738.794366309879, 3756.426847609396, 3768.5289338832645, 3769.6418840210135, 3781.905452363713, 5253.737313134252, 5346.117890548016, 5373.382061062872, 5395.433479484597, 5408.3509978802795, 5197.92203116946, 5216.591520289577, 5221.451747566451, 5229.895402091861, 5252.317198764136, 5099.51554602327, 5193.870153246199, 5208.218767184952, 5218.55642270396, 5223.7910483580235, 4924.104219875302, 5121.0, 5130.871208334161, 5133.8973220534635, 5143.92284115746, 5047.6214283929585, 5213.504717051874, 5240.004399164147, 5255.132903071103, 5265.631405801557, 5104.897902041864, 5114.130597798308, 5120.948790512196, 5121.692698438105, 5142.331496905378], "value": 3932.7244123385167, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4940403041296, 599.4425184578344, 633.6546582112749, 637.3467196123976, 669.3875104279583, 11178.944105279472, 11380.544778208872, 11633.302001879883, 11789.587364442246, 11825.113116516253, 12805.423755930982, 13214.603561893135, 13217.669558261048, 13254.204747715145, 13274.933625331883, 637.8405398650337, 809.4900212865915, 809.8420807942454, 811.2779626132717, 814.080089498867, 780.7306479264645, 784.396015068397, 784.7763387434583, 789.6643926331315, 793.5119901260712, 810.8094597769549, 812.2689579378548, 812.5368539932241, 816.0411516468156, 850.8383407152652, 665.5707068940507, 685.3557655803529, 804.569555287921, 805.0379796143611, 843.5023336231623, 503.9924401133986, 592.4431034827292, 592.6829146406652, 601.3655593349015, 610.6732897899647, 11723.824142637868, 11735.23720958135, 11795.646130616095, 11813.0, 11822.881771182265, 11245.0, 11266.493007814668, 11323.773524529463, 12003.3398163101, 12023.458944347438, 8612.741617751415, 8799.384043116985, 8813.206811386943, 8925.553722313858, 9087.818243635156, 3199.8880039198516, 3216.967830321714, 3236.2394837213237, 3238.1904523869034, 3295.802251864896, 45305.77347113243, 46020.76989615064, 46191.76904115491, 46422.30366544505, 46522.5347746525, 9958.55186516594, 9993.15058220045, 10002.199824014062, 10004.099631033241, 10060.798784024279, 17011.91494042522, 17134.314627414762, 17186.398476053528, 17359.82640173582, 17388.91305543464, 6566.507511936624, 6574.441172500296, 6616.669166541654, 6628.304028077079, 6699.5310328276555, 3585.5876574194303, 3656.8171591420323, 3699.0382500549513, 3744.7378683491893, 3810.447485114643, 2536.7843733282507, 2604.7265037170823, 2609.4650596627644, 2611.229687242268, 2613.294410509152, 499.840051183625, 502.29427654145985, 509.04299916157385, 513.0226917721747, 514.8558403646985, 424.4863714904938, 601.9849503762441, 632.9303776584572, 643.9356064393523, 644.1497223664718, 7817.022872140982, 7958.08482024563, 7973.481723687942, 8133.129380242577, 8173.060098088677, 518.8676887393691, 553.1868153813887, 571.4656795895851, 572.4876235769046, 576.6799426318433, 3833.15670552478, 3880.53215340402, 3967.1668949520345, 3990.341593637075, 4028.4964379452567, 56274.43725562692, 57217.42782572204, 58103.418965809804, 58174.0, 58210.417895821345, 50180.74909625429, 50345.0, 50854.93160547147, 51031.234531482056, 51830.48169518332, 40591.7970410152, 46318.0, 46731.29903051457, 47338.763306183246, 47398.763006184745, 7914.920850791418, 7949.1255961843, 8065.637046332812, 8241.670333186605, 8246.134155913544, 23716.407089822893, 26757.598636020084, 27349.726502734717, 27641.861790690917, 27649.170524884285, 32384.67615323911, 33628.32743345168, 34690.82654586711, 34975.0, 35659.46510802288, 10005.949970250102, 10221.591136354462, 10407.635732749317, 10427.322224055715, 10834.67495975122, 11691.415429228675, 11854.110941679237, 12001.339926303788, 12136.878631213574, 12203.816942745689, 10590.470476475992, 10807.82109543169, 10893.618723344645, 10974.506147223554, 11298.661040168809, 7416.925830741624, 9116.1339672731, 9433.245340372616, 10182.949085254526, 10429.269951103654, 10580.682579522627, 10693.786124277316, 10785.514651840844, 10955.397453140155, 11031.558737650405, 9224.215941644767, 9271.0, 9332.673356432493, 9356.391834530734, 9852.26108041914, 8930.955345223232, 9213.677521286723, 9345.626174952926, 9498.430094194371, 9556.61773529051], "value": 5774.197638168638, "unit": "score"}], "name": "dromaeo_css", "value": 6296.34302648192, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 107.0, 113.0, 112.0, 113.0, 102.0, 113.0, 113.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 164.0, 193.0, 132.0, 162.0, 157.0, 141.0, 188.0, 134.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 164.0, 162.0, 160.0, 160.0, 161.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 110.0, 114.0, 78.0, 74.0, 76.0, 116.0, 98.0, 73.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 143.0, 94.0, 96.0, 95.0, 141.0, 95.0, 95.0, 144.0], "value": 109.3, "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, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 65.0, 67.0, 65.0, 66.0, 81.0, 63.0, 62.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 70.0, 64.0, 66.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 85.0, 79.0, 79.0, 78.0, 80.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 132.0, 142.0, 132.0, 131.0, 133.0, 133.0, 166.0, 158.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 182.0, 178.0, 178.0, 175.0, 173.0, 177.0, 173.0, 173.0, 177.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 73.0, 74.0, 72.0, 72.0, 72.0, 73.0, 73.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1586.3000000000004, "alertThreshold": 2.0}]} 04:37:54 INFO - Return code: 0 04:37:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:37:54 ERROR - # TBPL SUCCESS # 04:37:54 INFO - Running post-action listener: _resource_record_post_action 04:37:54 INFO - Running post-run listener: _resource_record_post_run 04:37:55 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517230592; Read time: 12; Write time: 483616 04:37:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233795584; Read time: 0; Write time: 263716 04:37:55 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283258880; Read time: 12; Write time: 219884 04:37:55 INFO - Running post-run listener: _upload_blobber_files 04:37:55 INFO - Blob upload gear active. 04:37:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:37:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:56 INFO - (blobuploader) - INFO - Done attempting. 04:37:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:37:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:37:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:57 INFO - (blobuploader) - INFO - Done attempting. 04:37:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:57 INFO - Return code: 0 04:37:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94141b342fa12130acd94e7b8cfb62142f9da11af8571e7615e4707f35faaea9d6a073efeba358a8f424e5e5633b1c517dfcbf208b5382555416a84cc93ba2da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d304f5522ee1e684b736258d6cb9cac0832066788e9cf3ca79b10b933896e124e9d68c5f0d410ab2ca08ac01c04a0e65159348ab7f754311ba514e8b03232110"} 04:37:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:57 INFO - Contents: 04:37:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94141b342fa12130acd94e7b8cfb62142f9da11af8571e7615e4707f35faaea9d6a073efeba358a8f424e5e5633b1c517dfcbf208b5382555416a84cc93ba2da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d304f5522ee1e684b736258d6cb9cac0832066788e9cf3ca79b10b933896e124e9d68c5f0d410ab2ca08ac01c04a0e65159348ab7f754311ba514e8b03232110"} 04:37:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:37:57 INFO - Copying logs to upload dir... 04:37:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:37:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.002432 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-19 04:37:57.012779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:57.016470) ========= 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=836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94141b342fa12130acd94e7b8cfb62142f9da11af8571e7615e4707f35faaea9d6a073efeba358a8f424e5e5633b1c517dfcbf208b5382555416a84cc93ba2da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d304f5522ee1e684b736258d6cb9cac0832066788e9cf3ca79b10b933896e124e9d68c5f0d410ab2ca08ac01c04a0e65159348ab7f754311ba514e8b03232110"} build_url:https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/PI5SpEutRsKSG2Q6cfF60w/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/Firefox-Non-PGO/sha512/94141b342fa12130acd94e7b8cfb62142f9da11af8571e7615e4707f35faaea9d6a073efeba358a8f424e5e5633b1c517dfcbf208b5382555416a84cc93ba2da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d304f5522ee1e684b736258d6cb9cac0832066788e9cf3ca79b10b933896e124e9d68c5f0d410ab2ca08ac01c04a0e65159348ab7f754311ba514e8b03232110"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:57.041821) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:57.042161) ========= 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=836cfdc75598d54cb747368e000001a9-1461064386.182116-926155988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:57.127333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:37:57.127687) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:37:57.127992) ========= ========= Total master_lag: 0.17 =========