builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1460977273.5 results: success (0) buildid: 20160418013019 builduid: 0d4e264b61b747b9bc596e135c35b486 revision: 1f16d3da9280e40ada252acf8110b91ee1edbb08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:13.502795) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:13.503185) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:13.503456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:13.524274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:13.524561) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 04:01: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% 222M=0s 2016-04-18 04:01:14 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:13.652213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:13.652537) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:13.701861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:13.705241) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1f16d3da9280e40ada252acf8110b91ee1edbb08 --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 1f16d3da9280e40ada252acf8110b91ee1edbb08 --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=9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 04:01:14,874 truncating revision to first 12 chars 2016-04-18 04:01:14,874 Setting DEBUG logging. 2016-04-18 04:01:14,874 attempt 1/10 2016-04-18 04:01:14,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1f16d3da9280?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 04:01:15,166 unpacking tar archive at: mozilla-central-1f16d3da9280/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603268 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:14.324277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:14.324995) ========= script_repo_revision: 1f16d3da9280e40ada252acf8110b91ee1edbb08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:14.325537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:14.325809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 04:01:14.340227) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-18 04:01:14.340576) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:15 INFO - MultiFileLogger online at 20160418 04:01:15 in /builds/slave/test 04:01:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:01:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:15 INFO - {'append_to_log': False, 04:01:15 INFO - 'base_work_dir': '/builds/slave/test', 04:01:15 INFO - 'blob_upload_branch': 'Firefox', 04:01:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:15 INFO - 'branch': 'Firefox', 04:01:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:15 INFO - 'config_files': ('talos/linux_config.py',), 04:01:15 INFO - 'default_actions': ('clobber', 04:01:15 INFO - 'read-buildbot-config', 04:01:15 INFO - 'download-and-extract', 04:01:15 INFO - 'populate-webroot', 04:01:15 INFO - 'create-virtualenv', 04:01:15 INFO - 'install', 04:01:15 INFO - 'run-tests'), 04:01:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:15 INFO - 'download_minidump_stackwalk': True, 04:01:15 INFO - 'download_symbols': 'ondemand', 04:01:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:15 INFO - 'installer_path': 'installer.exe', 04:01:15 INFO - 'log_level': 'info', 04:01:15 INFO - 'log_name': 'talos', 04:01:15 INFO - 'log_to_console': True, 04:01:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:15 INFO - 'opt_config_files': (), 04:01:15 INFO - 'pip_index': False, 04:01:15 INFO - 'sps_profile': False, 04:01:15 INFO - 'sps_profile_interval': 0, 04:01:15 INFO - 'suite': 'dromaeojs', 04:01:15 INFO - 'system_bits': '32', 04:01:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:15 INFO - 'title': 'talos-linux64-ix-013', 04:01:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:15 INFO - 'use_talos_json': True, 04:01:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:15 INFO - 'work_dir': 'build'} 04:01:15 INFO - ##### 04:01:15 INFO - ##### Running clobber step. 04:01:15 INFO - ##### 04:01:15 INFO - Running pre-action listener: _resource_record_pre_action 04:01:15 INFO - Running main action method: clobber 04:01:15 INFO - rmtree: /builds/slave/test/build 04:01:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:16 INFO - Running post-action listener: _resource_record_post_action 04:01:16 INFO - ##### 04:01:16 INFO - ##### Running read-buildbot-config step. 04:01:16 INFO - ##### 04:01:16 INFO - Running pre-action listener: _resource_record_pre_action 04:01:16 INFO - Running main action method: read_buildbot_config 04:01:16 INFO - Using buildbot properties: 04:01:16 INFO - { 04:01:16 INFO - "project": "", 04:01:16 INFO - "product": "firefox", 04:01:16 INFO - "script_repo_revision": "production", 04:01:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:01:16 INFO - "repository": "", 04:01:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:01:16 INFO - "buildid": "20160418013019", 04:01:16 INFO - "pgo_build": "True", 04:01:16 INFO - "basedir": "/builds/slave/test", 04:01:16 INFO - "buildnumber": 264, 04:01:16 INFO - "slavename": "talos-linux64-ix-013", 04:01:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:01:16 INFO - "platform": "ubuntu64_hw", 04:01:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:01:16 INFO - "branch": "mozilla-central", 04:01:16 INFO - "repo_path": "mozilla-central", 04:01:16 INFO - "revision": "1f16d3da9280e40ada252acf8110b91ee1edbb08", 04:01:16 INFO - "stage_platform": "linux64-pgo", 04:01:16 INFO - "builduid": "0d4e264b61b747b9bc596e135c35b486", 04:01:16 INFO - "slavebuilddir": "test" 04:01:16 INFO - } 04:01:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:01:16 INFO - Running post-action listener: _resource_record_post_action 04:01:16 INFO - ##### 04:01:16 INFO - ##### Running download-and-extract step. 04:01:16 INFO - ##### 04:01:16 INFO - Running pre-action listener: _resource_record_pre_action 04:01:16 INFO - Running main action method: download_and_extract 04:01:16 INFO - mkdir: /builds/slave/test/build/tests 04:01: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:01:16 INFO - https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:01:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:01:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:01:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:19 INFO - Downloaded 1361 bytes. 04:01:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:01:19 INFO - Using the following test package requirements: 04:01:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:01:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:01:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:19 INFO - u'jsshell-linux-x86_64.zip'], 04:01:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:01:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:01:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:01:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:01: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:01:19 INFO - https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:21 INFO - Downloaded 23775041 bytes. 04:01: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:01: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:01:22 INFO - Return code: 0 04:01: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:01: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:01:22 INFO - https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:26 INFO - Downloaded 23775041 bytes. 04:01: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:01: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:01:27 INFO - Return code: 0 04:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:27 INFO - https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:29 INFO - Downloaded 10841076 bytes. 04:01: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:01: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:01:29 INFO - Return code: 0 04:01: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:01:29 INFO - https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:01:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:01:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:01:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Po-ZvWqrRHeEazc5_bq08w/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:01:30 INFO - Downloaded 58245435 bytes. 04:01:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:01:30 INFO - mkdir: /builds/slave/test/properties 04:01:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:30 INFO - Contents: 04:01:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:01:31 INFO - Running post-action listener: _resource_record_post_action 04:01:31 INFO - Running post-action listener: set_extra_try_arguments 04:01:31 INFO - ##### 04:01:31 INFO - ##### Running populate-webroot step. 04:01:31 INFO - ##### 04:01:31 INFO - Running pre-action listener: _resource_record_pre_action 04:01:31 INFO - Running main action method: populate_webroot 04:01:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:31 INFO - '--tppagecycles', 04:01:31 INFO - '7'], 04:01:31 INFO - 'tests': ['tsvgm']}}, 04:01:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:31 INFO - 'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:31 INFO - 'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['damp', 'tps']}, 04:01:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:31 INFO - 'tests': ['damp', 'tps']}, 04:01:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['dromaeo_dom']}, 04:01:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['a11yr', 04:01:31 INFO - 'ts_paint', 04:01:31 INFO - 'tpaint', 04:01:31 INFO - 'sessionrestore', 04:01:31 INFO - 'sessionrestore_no_auto_restore', 04:01:31 INFO - 'tabpaint']}, 04:01:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:31 INFO - 'ts_paint', 04:01:31 INFO - 'tpaint', 04:01:31 INFO - 'sessionrestore', 04:01:31 INFO - 'sessionrestore_no_auto_restore', 04:01:31 INFO - 'tabpaint']}, 04:01:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:31 INFO - 'ts_paint', 04:01:31 INFO - 'tpaint', 04:01:31 INFO - 'sessionrestore', 04:01:31 INFO - 'sessionrestore_no_auto_restore', 04:01:31 INFO - 'tabpaint']}, 04:01:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:31 INFO - 'ts_paint', 04:01:31 INFO - 'tpaint', 04:01:31 INFO - 'sessionrestore', 04:01:31 INFO - 'sessionrestore_no_auto_restore', 04:01:31 INFO - 'tabpaint']}, 04:01:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['a11yr', 04:01:31 INFO - 'ts_paint', 04:01:31 INFO - 'tpaint', 04:01:31 INFO - 'sessionrestore', 04:01:31 INFO - 'sessionrestore_no_auto_restore', 04:01:31 INFO - 'tabpaint']}, 04:01:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['a11yr', 04:01:31 INFO - 'ts_paint', 04:01:31 INFO - 'tpaint', 04:01:31 INFO - 'sessionrestore', 04:01:31 INFO - 'sessionrestore_no_auto_restore', 04:01:31 INFO - 'tabpaint']}, 04:01:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['tsvgx', 04:01:31 INFO - 'tsvgr_opacity', 04:01:31 INFO - 'tart', 04:01:31 INFO - 'tscrollx', 04:01:31 INFO - 'cart']}, 04:01:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:31 INFO - 'tsvgr_opacity', 04:01:31 INFO - 'tart', 04:01:31 INFO - 'tscrollx', 04:01:31 INFO - 'cart']}, 04:01:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:31 INFO - 'talos_options': ['--disable-e10s'], 04:01:31 INFO - 'tests': ['tp5o']}, 04:01:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:31 INFO - 'tests': ['tp5o']}, 04:01:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:31 INFO - 'talos_options': ['--disable-e10s', 04:01:31 INFO - '--xperf_path', 04:01:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:31 INFO - 'tests': ['tp5n']}, 04:01:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:31 INFO - 'talos_options': ['--xperf_path', 04:01:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:31 INFO - 'tests': ['tp5n']}}, 04:01:31 INFO - 'talos.zip': {'path': '', 04:01:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:31 INFO - Running post-action listener: _resource_record_post_action 04:01:31 INFO - ##### 04:01:31 INFO - ##### Running create-virtualenv step. 04:01:31 INFO - ##### 04:01:31 INFO - Running pre-action listener: _resource_record_pre_action 04:01:31 INFO - Running main action method: create_virtualenv 04:01:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01: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:01:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:31 INFO - Using real prefix '/usr' 04:01:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:34 INFO - Installing pip.................done. 04:01:34 INFO - Return code: 0 04:01:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01: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:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc06ad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15569a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', '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:01: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', 'pip>=1.5'] in /builds/slave/test/build 04:01: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 pip>=1.5 04:01:34 INFO - Using env: {'DISPLAY': ':0', 04:01:34 INFO - 'HOME': '/home/cltbld', 04:01:34 INFO - 'LANG': 'en_US.UTF-8', 04:01:34 INFO - 'LANGUAGE': 'en_US:en', 04:01:34 INFO - 'LOGNAME': 'cltbld', 04:01:34 INFO - 'MAIL': '/var/mail/cltbld', 04:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:34 INFO - 'MOZ_NO_REMOTE': '1', 04:01:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:34 INFO - 'NO_EM_RESTART': '1', 04:01:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:34 INFO - 'PWD': '/builds/slave/test', 04:01:34 INFO - 'SHELL': '/bin/bash', 04:01:34 INFO - 'SHLVL': '1', 04:01:34 INFO - 'TERM': 'linux', 04:01:34 INFO - 'TMOUT': '86400', 04:01:34 INFO - 'USER': 'cltbld', 04:01:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:34 INFO - '_': '/tools/buildbot/bin/python'} 04:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01: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:01:34 INFO - Cleaning up... 04:01:34 INFO - Return code: 0 04:01:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:01: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:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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 0x7fcc06ad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15569a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', '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:01: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:01: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:01:34 INFO - Using env: {'DISPLAY': ':0', 04:01:34 INFO - 'HOME': '/home/cltbld', 04:01:34 INFO - 'LANG': 'en_US.UTF-8', 04:01:34 INFO - 'LANGUAGE': 'en_US:en', 04:01:34 INFO - 'LOGNAME': 'cltbld', 04:01:34 INFO - 'MAIL': '/var/mail/cltbld', 04:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:34 INFO - 'MOZ_NO_REMOTE': '1', 04:01:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:34 INFO - 'NO_EM_RESTART': '1', 04:01:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:34 INFO - 'PWD': '/builds/slave/test', 04:01:34 INFO - 'SHELL': '/bin/bash', 04:01:34 INFO - 'SHLVL': '1', 04:01:34 INFO - 'TERM': 'linux', 04:01:34 INFO - 'TMOUT': '86400', 04:01:34 INFO - 'USER': 'cltbld', 04:01:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:34 INFO - '_': '/tools/buildbot/bin/python'} 04:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:34 INFO - Downloading/unpacking psutil>=0.7.1 04:01: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:01: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:01: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:01: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:01: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:01: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:01:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:36 INFO - Installing collected packages: psutil 04:01:36 INFO - Running setup.py install for psutil 04:01:36 INFO - building 'psutil._psutil_linux' extension 04:01: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:01: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:01:37 INFO - building 'psutil._psutil_posix' extension 04:01:37 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:01:37 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:01:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:37 INFO - Successfully installed psutil 04:01:37 INFO - Cleaning up... 04:01:37 INFO - Return code: 0 04:01:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:01:37 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:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:37 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:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:37 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 0x7fcc06ad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15569a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', '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:01:37 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:01:37 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:01:37 INFO - Using env: {'DISPLAY': ':0', 04:01:37 INFO - 'HOME': '/home/cltbld', 04:01:37 INFO - 'LANG': 'en_US.UTF-8', 04:01:37 INFO - 'LANGUAGE': 'en_US:en', 04:01:37 INFO - 'LOGNAME': 'cltbld', 04:01:37 INFO - 'MAIL': '/var/mail/cltbld', 04:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:37 INFO - 'MOZ_NO_REMOTE': '1', 04:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:37 INFO - 'NO_EM_RESTART': '1', 04:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:37 INFO - 'PWD': '/builds/slave/test', 04:01:37 INFO - 'SHELL': '/bin/bash', 04:01:37 INFO - 'SHLVL': '1', 04:01:37 INFO - 'TERM': 'linux', 04:01:37 INFO - 'TMOUT': '86400', 04:01:37 INFO - 'USER': 'cltbld', 04:01:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:37 INFO - '_': '/tools/buildbot/bin/python'} 04:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:01: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:01: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:01: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:01: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:01: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:01: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:01:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01: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:01:39 INFO - Installing collected packages: mozsystemmonitor 04:01:39 INFO - Running setup.py install for mozsystemmonitor 04:01:39 INFO - Successfully installed mozsystemmonitor 04:01:39 INFO - Cleaning up... 04:01:39 INFO - Return code: 0 04:01:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01: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:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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 0x7fcc06ad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15569a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', '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:01: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:01: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:01:39 INFO - Using env: {'DISPLAY': ':0', 04:01:39 INFO - 'HOME': '/home/cltbld', 04:01:39 INFO - 'LANG': 'en_US.UTF-8', 04:01:39 INFO - 'LANGUAGE': 'en_US:en', 04:01:39 INFO - 'LOGNAME': 'cltbld', 04:01:39 INFO - 'MAIL': '/var/mail/cltbld', 04:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:39 INFO - 'MOZ_NO_REMOTE': '1', 04:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:39 INFO - 'NO_EM_RESTART': '1', 04:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:39 INFO - 'PWD': '/builds/slave/test', 04:01:39 INFO - 'SHELL': '/bin/bash', 04:01:39 INFO - 'SHLVL': '1', 04:01:39 INFO - 'TERM': 'linux', 04:01:39 INFO - 'TMOUT': '86400', 04:01:39 INFO - 'USER': 'cltbld', 04:01:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:39 INFO - '_': '/tools/buildbot/bin/python'} 04:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:01: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:01: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:01: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:01: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:01: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:01: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:01:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01: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:01: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:01: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:01: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:01: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:01: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:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:42 INFO - Downloading docopt-0.6.1.tar.gz 04:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:42 INFO - Running setup.py install for blobuploader 04:01:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:42 INFO - Running setup.py install for requests 04:01:42 INFO - Running setup.py install for docopt 04:01:43 INFO - Successfully installed blobuploader requests docopt 04:01:43 INFO - Cleaning up... 04:01:43 INFO - Return code: 0 04:01:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:43 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 0x7fcc06ad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15569a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', '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:01:43 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:01:43 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:01:43 INFO - Using env: {'DISPLAY': ':0', 04:01:43 INFO - 'HOME': '/home/cltbld', 04:01:43 INFO - 'LANG': 'en_US.UTF-8', 04:01:43 INFO - 'LANGUAGE': 'en_US:en', 04:01:43 INFO - 'LOGNAME': 'cltbld', 04:01:43 INFO - 'MAIL': '/var/mail/cltbld', 04:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:43 INFO - 'MOZ_NO_REMOTE': '1', 04:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:43 INFO - 'NO_EM_RESTART': '1', 04:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:43 INFO - 'PWD': '/builds/slave/test', 04:01:43 INFO - 'SHELL': '/bin/bash', 04:01:43 INFO - 'SHLVL': '1', 04:01:43 INFO - 'TERM': 'linux', 04:01:43 INFO - 'TMOUT': '86400', 04:01:43 INFO - 'USER': 'cltbld', 04:01:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:43 INFO - '_': '/tools/buildbot/bin/python'} 04:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:43 INFO - Running setup.py (path:/tmp/pip-XIK4rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:43 INFO - Running setup.py (path:/tmp/pip-XO3e0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:43 INFO - Running setup.py (path:/tmp/pip-BOc9J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:43 INFO - Running setup.py (path:/tmp/pip-RVxZHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:43 INFO - Running setup.py (path:/tmp/pip-Yk4lIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:43 INFO - Running setup.py (path:/tmp/pip-GVeiRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:43 INFO - Running setup.py (path:/tmp/pip-xtxyjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:43 INFO - Running setup.py (path:/tmp/pip-nnnMju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:43 INFO - Running setup.py (path:/tmp/pip-AlVUBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:43 INFO - Running setup.py (path:/tmp/pip-vpNln4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:44 INFO - Running setup.py (path:/tmp/pip-DLVBok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:44 INFO - Running setup.py (path:/tmp/pip-dOAr5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:44 INFO - Running setup.py (path:/tmp/pip-BAdWcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:44 INFO - Running setup.py (path:/tmp/pip-PAzKlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:44 INFO - Running setup.py (path:/tmp/pip-mfp2v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:44 INFO - Running setup.py (path:/tmp/pip-Ia32qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:44 INFO - Running setup.py (path:/tmp/pip-gxskgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:44 INFO - Running setup.py install for manifestparser 04:01:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:44 INFO - Running setup.py install for mozcrash 04:01:44 INFO - Running setup.py install for mozdebug 04:01:44 INFO - Running setup.py install for mozdevice 04:01:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:44 INFO - Running setup.py install for mozfile 04:01:45 INFO - Running setup.py install for mozhttpd 04:01:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Running setup.py install for mozinfo 04:01:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Running setup.py install for mozInstall 04:01:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Running setup.py install for mozleak 04:01:45 INFO - Running setup.py install for mozlog 04:01:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Running setup.py install for moznetwork 04:01:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Running setup.py install for mozprocess 04:01:45 INFO - Running setup.py install for mozprofile 04:01:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:45 INFO - Running setup.py install for mozrunner 04:01:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:46 INFO - Running setup.py install for mozscreenshot 04:01:46 INFO - Running setup.py install for moztest 04:01:46 INFO - Running setup.py install for mozversion 04:01:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:46 INFO - Cleaning up... 04:01:46 INFO - Return code: 0 04:01:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:46 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 0x7fcc06ad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15569a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', '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:01:46 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:01:46 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:01:46 INFO - Using env: {'DISPLAY': ':0', 04:01:46 INFO - 'HOME': '/home/cltbld', 04:01:46 INFO - 'LANG': 'en_US.UTF-8', 04:01:46 INFO - 'LANGUAGE': 'en_US:en', 04:01:46 INFO - 'LOGNAME': 'cltbld', 04:01:46 INFO - 'MAIL': '/var/mail/cltbld', 04:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:46 INFO - 'MOZ_NO_REMOTE': '1', 04:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:46 INFO - 'NO_EM_RESTART': '1', 04:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:46 INFO - 'PWD': '/builds/slave/test', 04:01:46 INFO - 'SHELL': '/bin/bash', 04:01:46 INFO - 'SHLVL': '1', 04:01:46 INFO - 'TERM': 'linux', 04:01:46 INFO - 'TMOUT': '86400', 04:01:46 INFO - 'USER': 'cltbld', 04:01:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:46 INFO - '_': '/tools/buildbot/bin/python'} 04:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:46 INFO - Running setup.py (path:/tmp/pip-jl6cAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01: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:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:46 INFO - Running setup.py (path:/tmp/pip-W74qBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01: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:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:46 INFO - Running setup.py (path:/tmp/pip-Tp1QH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01: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:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:46 INFO - Running setup.py (path:/tmp/pip-UBn5Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01: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:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:46 INFO - Running setup.py (path:/tmp/pip-FbsCVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01: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:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:46 INFO - Running setup.py (path:/tmp/pip-NTYqTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01: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:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:46 INFO - Running setup.py (path:/tmp/pip-i2o8_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:47 INFO - Running setup.py (path:/tmp/pip-O3xlw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:47 INFO - Running setup.py (path:/tmp/pip-VQcbuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:47 INFO - Running setup.py (path:/tmp/pip-uE6xR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:47 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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:47 INFO - Running setup.py (path:/tmp/pip-RYkkqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01: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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:47 INFO - Running setup.py (path:/tmp/pip-03Y3M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01: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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:47 INFO - Running setup.py (path:/tmp/pip-yxRSA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01: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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:47 INFO - Running setup.py (path:/tmp/pip-RnPYVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01: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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:47 INFO - Running setup.py (path:/tmp/pip-w0h3tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01: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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:47 INFO - Running setup.py (path:/tmp/pip-RVER9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01: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:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:47 INFO - Running setup.py (path:/tmp/pip-cOrQLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01: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:01: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:01: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:01: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:01: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:01: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:01:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01: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:01: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:01: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:01: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:01: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:01: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:01:49 INFO - Downloading blessings-1.6.tar.gz 04:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:49 INFO - Installing collected packages: blessings 04:01:49 INFO - Running setup.py install for blessings 04:01:49 INFO - Successfully installed blessings 04:01:49 INFO - Cleaning up... 04:01:50 INFO - Return code: 0 04:01:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:50 INFO - Reading from file tmpfile_stdout 04:01:50 INFO - Current package versions: 04:01:50 INFO - argparse == 1.2.1 04:01:50 INFO - blessings == 1.6 04:01:50 INFO - blobuploader == 1.2.4 04:01:50 INFO - docopt == 0.6.1 04:01:50 INFO - manifestparser == 1.1 04:01:50 INFO - mozInstall == 1.12 04:01:50 INFO - mozcrash == 0.17 04:01:50 INFO - mozdebug == 0.1 04:01:50 INFO - mozdevice == 0.48 04:01:50 INFO - mozfile == 1.2 04:01:50 INFO - mozhttpd == 0.7 04:01:50 INFO - mozinfo == 0.9 04:01:50 INFO - mozleak == 0.1 04:01:50 INFO - mozlog == 3.1 04:01:50 INFO - moznetwork == 0.27 04:01:50 INFO - mozprocess == 0.22 04:01:50 INFO - mozprofile == 0.28 04:01:50 INFO - mozrunner == 6.11 04:01:50 INFO - mozscreenshot == 0.1 04:01:50 INFO - mozsystemmonitor == 0.0 04:01:50 INFO - moztest == 0.7 04:01:50 INFO - mozversion == 1.4 04:01:50 INFO - psutil == 3.1.1 04:01:50 INFO - requests == 1.2.3 04:01:50 INFO - wsgiref == 0.1.2 04:01:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01: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:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:50 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 0x7fcc06ad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15569a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', '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:01:50 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:01:50 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:01:50 INFO - Using env: {'DISPLAY': ':0', 04:01:50 INFO - 'HOME': '/home/cltbld', 04:01:50 INFO - 'LANG': 'en_US.UTF-8', 04:01:50 INFO - 'LANGUAGE': 'en_US:en', 04:01:50 INFO - 'LOGNAME': 'cltbld', 04:01:50 INFO - 'MAIL': '/var/mail/cltbld', 04:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:50 INFO - 'MOZ_NO_REMOTE': '1', 04:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:50 INFO - 'NO_EM_RESTART': '1', 04:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:50 INFO - 'PWD': '/builds/slave/test', 04:01:50 INFO - 'SHELL': '/bin/bash', 04:01:50 INFO - 'SHLVL': '1', 04:01:50 INFO - 'TERM': 'linux', 04:01:50 INFO - 'TMOUT': '86400', 04:01:50 INFO - 'USER': 'cltbld', 04:01:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:50 INFO - '_': '/tools/buildbot/bin/python'} 04:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 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:01:50 INFO - Cleaning up... 04:01:50 INFO - Return code: 0 04:01:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01: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:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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 0x7fcc06ad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15569a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', '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:01: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:01: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:01:50 INFO - Using env: {'DISPLAY': ':0', 04:01:50 INFO - 'HOME': '/home/cltbld', 04:01:50 INFO - 'LANG': 'en_US.UTF-8', 04:01:50 INFO - 'LANGUAGE': 'en_US:en', 04:01:50 INFO - 'LOGNAME': 'cltbld', 04:01:50 INFO - 'MAIL': '/var/mail/cltbld', 04:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:50 INFO - 'MOZ_NO_REMOTE': '1', 04:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:50 INFO - 'NO_EM_RESTART': '1', 04:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:50 INFO - 'PWD': '/builds/slave/test', 04:01:50 INFO - 'SHELL': '/bin/bash', 04:01:50 INFO - 'SHLVL': '1', 04:01:50 INFO - 'TERM': 'linux', 04:01:50 INFO - 'TMOUT': '86400', 04:01:50 INFO - 'USER': 'cltbld', 04:01:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:50 INFO - '_': '/tools/buildbot/bin/python'} 04:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:50 INFO - Downloading/unpacking jsonschema 04:01: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:01: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:01: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:01: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:01: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:01: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:01:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:52 INFO - Downloading/unpacking functools32 (from jsonschema) 04:01: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:01: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:01: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:01: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:01: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:01: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:01:52 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:52 INFO - warning: no files found matching '*.txt' 04:01:52 INFO - no previously-included directories found matching 'build' 04:01:52 INFO - no previously-included directories found matching 'dist' 04:01:52 INFO - no previously-included directories found matching '.git*' 04:01:52 INFO - Installing collected packages: jsonschema, functools32 04:01:52 INFO - Running setup.py install for functools32 04:01:52 INFO - warning: no files found matching '*.txt' 04:01:52 INFO - no previously-included directories found matching 'build' 04:01:52 INFO - no previously-included directories found matching 'dist' 04:01:52 INFO - no previously-included directories found matching '.git*' 04:01:52 INFO - Successfully installed jsonschema functools32 04:01:52 INFO - Cleaning up... 04:01:52 INFO - Return code: 0 04:01:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:01: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:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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 0x7fcc06ad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15569a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', '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:01: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:01: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:01:52 INFO - Using env: {'DISPLAY': ':0', 04:01:52 INFO - 'HOME': '/home/cltbld', 04:01:53 INFO - 'LANG': 'en_US.UTF-8', 04:01:53 INFO - 'LANGUAGE': 'en_US:en', 04:01:53 INFO - 'LOGNAME': 'cltbld', 04:01:53 INFO - 'MAIL': '/var/mail/cltbld', 04:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:53 INFO - 'MOZ_NO_REMOTE': '1', 04:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:53 INFO - 'NO_EM_RESTART': '1', 04:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:53 INFO - 'PWD': '/builds/slave/test', 04:01:53 INFO - 'SHELL': '/bin/bash', 04:01:53 INFO - 'SHLVL': '1', 04:01:53 INFO - 'TERM': 'linux', 04:01:53 INFO - 'TMOUT': '86400', 04:01:53 INFO - 'USER': 'cltbld', 04:01:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:53 INFO - '_': '/tools/buildbot/bin/python'} 04:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:53 INFO - Downloading/unpacking flake8 04:01:53 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:01:53 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:01:53 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:01:53 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:01:53 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:01:53 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:01:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:01:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:01: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:01: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:01: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:01: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:01: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:01: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:01:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:01:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:01: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:01: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:01: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:01: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:01: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:01: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:01:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:01: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:01: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:01: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:01: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:01: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:01: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:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:55 INFO - no previously-included directories found matching 'docs/_build' 04:01:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:01:55 INFO - Running setup.py install for pep8 04:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:55 INFO - no previously-included directories found matching 'docs/_build' 04:01:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:01:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:01:55 INFO - Cleaning up... 04:01:56 INFO - Return code: 0 04:01:56 INFO - Running post-action listener: _resource_record_post_action 04:01:56 INFO - Running post-action listener: _start_resource_monitoring 04:01:56 INFO - Starting resource monitoring. 04:01:56 INFO - ##### 04:01:56 INFO - ##### Running install step. 04:01:56 INFO - ##### 04:01:56 INFO - Running pre-action listener: _resource_record_pre_action 04:01:56 INFO - Running main action method: install 04:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:56 INFO - Reading from file tmpfile_stdout 04:01:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:01:56 INFO - Reading from file tmpfile_stdout 04:01:56 INFO - Output received: 04:01:56 INFO - Usage: mozinstall [options] installer 04:01:56 INFO - Options: 04:01:56 INFO - -h, --help show this help message and exit 04:01:56 INFO - -d DEST, --destination=DEST 04:01:56 INFO - Directory to install application into. [default: 04:01:56 INFO - "/builds/slave/test"] 04:01:56 INFO - --app=APP Application being installed. [default: firefox] 04:01:56 INFO - mkdir: /builds/slave/test/build/application 04:01:56 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:01:56 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:02:12 INFO - Reading from file tmpfile_stdout 04:02:12 INFO - Output received: 04:02:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:12 INFO - Running post-action listener: _resource_record_post_action 04:02:12 INFO - ##### 04:02:12 INFO - ##### Running run-tests step. 04:02:12 INFO - ##### 04:02:12 INFO - Running pre-action listener: _resource_record_pre_action 04:02:12 INFO - Running main action method: run_tests 04:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:12 INFO - Python 2.7.3 04:02:12 INFO - Return code: 0 04:02:12 INFO - grabbing minidump binary from tooltool 04:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:12 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 0x15e5810>, '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 0x15e6710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:12 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:02:12 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:02:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:12 INFO - Return code: 0 04:02:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:02:14 INFO - Return code: 0 04:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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:02:14 INFO - Using env: {'DISPLAY': ':0', 04:02:14 INFO - 'HOME': '/home/cltbld', 04:02:14 INFO - 'LANG': 'en_US.UTF-8', 04:02:14 INFO - 'LANGUAGE': 'en_US:en', 04:02:14 INFO - 'LOGNAME': 'cltbld', 04:02:14 INFO - 'MAIL': '/var/mail/cltbld', 04:02:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:14 INFO - 'MOZ_NO_REMOTE': '1', 04:02:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:14 INFO - 'NO_EM_RESTART': '1', 04:02:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:14 INFO - 'PWD': '/builds/slave/test', 04:02:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:14 INFO - 'SHELL': '/bin/bash', 04:02:14 INFO - 'SHLVL': '1', 04:02:14 INFO - 'TERM': 'linux', 04:02:14 INFO - 'TMOUT': '86400', 04:02:14 INFO - 'USER': 'cltbld', 04:02:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828', 04:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:14 INFO - '_': '/tools/buildbot/bin/python'} 04:02:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:02:14 INFO - mozversion application_buildid: 20160418013019 04:02:14 INFO - mozversion application_changeset: 1f16d3da9280e40ada252acf8110b91ee1edbb08 04:02:14 INFO - mozversion application_display_name: Nightly 04:02:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:14 INFO - mozversion application_name: Firefox 04:02:14 INFO - mozversion application_remotingname: firefox 04:02:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:02:14 INFO - mozversion application_vendor: Mozilla 04:02:14 INFO - mozversion application_version: 48.0a1 04:02:14 INFO - mozversion platform_buildid: 20160418013019 04:02:14 INFO - mozversion platform_changeset: 1f16d3da9280e40ada252acf8110b91ee1edbb08 04:02:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:02:14 INFO - mozversion platform_version: 48.0a1 04:02:14 INFO - using testdate: 1460977334 04:02:14 INFO - actual date: 1460977334 04:02:14 INFO - starting webserver on 'localhost:59924' 04:02:14 INFO - SUITE-START | Running 2 tests 04:02:14 INFO - TEST-START | dromaeo_css 04:02:14 INFO - operating with platform_type : linux_ 04:02:14 INFO - Initialising browser for dromaeo_css test... 04:02:14 INFO - TEST-INFO | started process 31517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRyLSfi/profile http://localhost:59924/getInfo.html) 04:02:18 INFO - PROCESS | 31517 | __metrics Screen width/height:1600/1200 04:02:18 INFO - PROCESS | 31517 | colorDepth:24 04:02:18 INFO - PROCESS | 31517 | Browser inner width/height: 1024/697 04:02:18 INFO - PROCESS | 31517 | __metrics 04:02:19 ERROR - PROCESS | 31517 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:02:20 INFO - TEST-INFO | 31517: exit 0 04:02:20 INFO - Browser initialized. 04:02:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:20 INFO - TEST-INFO | started process 31600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRyLSfi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:32 INFO - PROCESS | 31600 | RSS: Main: 153530368 04:02:32 INFO - PROCESS | 31600 | 04:03:22 INFO - PROCESS | 31600 | 1460977402840 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:05:30 INFO - PROCESS | 31600 | Cycle 1(1): loaded http://localhost:59924/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59924/tests/dromaeo/cssquery-ext.html) 04:05:31 INFO - PROCESS | 31600 | RSS: Main: 244727808 04:05:31 INFO - PROCESS | 31600 | 04:08:33 INFO - PROCESS | 31600 | Cycle 1(1): loaded http://localhost:59924/tests/dromaeo/cssquery-ext.html (next: http://localhost:59924/tests/dromaeo/cssquery-jquery.html) 04:08:33 INFO - PROCESS | 31600 | RSS: Main: 236122112 04:08:33 INFO - PROCESS | 31600 | 04:11:35 INFO - PROCESS | 31600 | Cycle 1(1): loaded http://localhost:59924/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59924/tests/dromaeo/cssquery-mootools.html) 04:11:36 INFO - PROCESS | 31600 | RSS: Main: 244994048 04:11:36 INFO - PROCESS | 31600 | 04:14:38 INFO - PROCESS | 31600 | Cycle 1(1): loaded http://localhost:59924/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59924/tests/dromaeo/cssquery-prototype.html) 04:14:38 INFO - PROCESS | 31600 | RSS: Main: 230723584 04:14:38 INFO - PROCESS | 31600 | 04:17:41 INFO - PROCESS | 31600 | Cycle 1(1): loaded http://localhost:59924/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59924/tests/dromaeo/cssquery-yui.html) 04:17:42 INFO - PROCESS | 31600 | RSS: Main: 222060544 04:17:42 INFO - PROCESS | 31600 | 04:20:44 INFO - PROCESS | 31600 | Cycle 1(1): loaded http://localhost:59924/tests/dromaeo/cssquery-yui.html (next: http://localhost:59924/tests/dromaeo/cssquery-dojo.html) 04:20:44 INFO - PROCESS | 31600 | RSS: Main: 286224384 04:20:44 INFO - PROCESS | 31600 | 04:20:44 INFO - PROCESS | 31600 | __start_tp_report 04:20:44 INFO - PROCESS | 31600 | _x_x_mozilla_page_load 04:20:44 INFO - PROCESS | 31600 | _x_x_mozilla_page_load_details 04:20:44 INFO - PROCESS | 31600 | |i|pagename|runs| 04:20:44 INFO - PROCESS | 31600 | |0;dojo.html;3012.2619958110267;3057.55665428513;3090.0420869530462;3091.1190310761435;3113.875444982201;5067.467915868836;5164.225366195073;5179.533841954223;5230.503102205289;5230.712310822908;5198.6880787152795;5216;5218.32161818963;5238.738063096849;5276.419593844674;4632.722036677793;4683.133620280242;4772.093302272575;4821.807127714887;4837.105135549935;4774.570288674018;4791.305260737191;4815.807367705288;4821.710697358169;4881.585065269456;4650.581447669709;4708.552687494683;4750.643701722384;4793.976030119827;4796.592289655384;4695.765211739399;4726.385569875929;4730.668853180278;4743.288506723985;4787.234042553209;4679.789409476582;4703.6942598730975;4718.740469274188;4732.124556956974;4739.36018637483;5039.72281524516;5117.795288188468;5160.122779127557;5190.792368305263;5193.324867767204;5477.20580515823;5484.945150548523;5487.533559647435;5488.9725551372385;5491.203775452537;5448.182772584105;5530.861728456781;5534.889302213974;5536.723163841792;5540.612157149001;5151.330327057459;5155.226715992593;5178.948210517922;5193.402758682762;5219.556337711261;5615.101583746581;5622.85942851432;5626.099824028136;5627.634203776742;5667.234923285386;5361.973190134102;5416.566674666017;5420.620556561082;5424.430434804289;5466.262054622575;5545.223668686387;5562.332520097614;5572.164175373727;5574.331080270394;5618.325800903917;5543.7782488700805;5554.472325129106;5556.083246264402;5557.805476808292;5566.192902029264;5368.302120724281;5442.809501667422;5501.642393244426;5551.750171242304;5615.578831587647;4182.769947652848;4184.3932629768515;4185.079282557833;4220.514640816284;4224.176285624335;3765.322241996467;3768.8115594220726;3768.849246030128;3800.3729384651224;3802.9429558556644;5145.202493613496;5238.8166414176085;5264.6051546134195;5281.577473802086;5333.200019996954;5482.725863706799;5486.945130548644;5489.945100549024;5505.6696598204235;5558.805441809598;5197.324347834833;5200.037992971313;5201.271821944931;5215.295935048795;5247.370315562157;4674.065186962621;4757.024809914029;4766.380370551806;4801.279808028754;4829.492903245179;5698.2592263005545;5704.857378565569;5706.514946229534;5708;5719.999000174953;5516.310461192351;5525.557955363481;5534.363548192009;5537.197106419627;5574.721263936868;5628.324601047901;5690.971545142248;5700.543956483389;5737.454941780524;5751.367349591458;5426.186072089218;5430.321209848769;5431.8098866539485;5434.972825135849;5445.292112025411;5381.1121165007335;5528.004959107399;5530.778768849201;5531.529819965187;5581.944180558305;5398.325209348832;5435.211894275387;5436.293281873489;5437.238786569805;5480.698561578992;5371.435999220025;5372.650777699437;5384.326959130109;5389.218563308376;5392.649477783932;5166.922496162485;5313.760880760452;5322.654027488201;5339.46605339463;5350.678959262456;5451.400345962021;5457.672539647634;5467.125259958388;5468.644538105011;5505.201745746925;5343.62594618373;5347.759350829144;5348.384935732441;5351.117065684119;5352.892942141213 04:20:44 INFO - PROCESS | 31600 | |1;ext.html;603.6649659439013;637.1939496536885;638.5593940181275;656.5830697507084;674.0798809624863;30139.24651883701;36992;37777.99999999996;37889;38030.42954355687;40277;40792.38811417824;40937.59062409375;40944.38583421251;41030.794846025725;7641.121271053817;8477.95761021194;8684.131586841297;8690.695825646071;9844.950775246114;9860.359076659994;10038.648647297347;10040.548175332127;10042.84935725961;10047.397156170617;10055.849162262572;10114.544845481934;10123.341982771133;10128.949355253213;10135.138513226384;7841.490303130278;9982.50087495626;10051.798964020678;10235.130013948823;10642.680719578426;10055.949720251425;10186.185105191567;10202.285839991204;10215.89784102157;10222.591096356211;36861.262774744624;37452.19108566841;37456.25087498235;37500.43749343762;37522.24955500902;3545.1137215696076;3629.237860049393;3632.0556655269556;3785.9621403785886;3866.5553461352024;32048.359032819448;32419.51370729441;32556.674433255837;32777.50833737496;32849.34301313984;4279.700420970534;4359.433273674434;4394.318880573516;4394.560543945612;4394.736315821061;287086;288296;288895;289451;289801;56035;56866;56996.715016424656;57103.71448142733;57117.42882571121;60961.39038609557;61184;61223;61274.38725612776;61349.38650613437;16398.6720265594;16914.407995720092;16945.661086778196;16958.745618815727;16979.066151361545;12906.161099528501;12974.675633109247;12982.15615984958;13004.674883127998;13006;17026;17285.827141728674;17538.736918946226;17663.20515576802;17667.29330826778;5433.646812957145;6427.614343139333;6533.444657204191;6605;6796.490263230277;1055.5302890213934;1141.6509342807424;1146.0258780037068;1186.2467333243453;1237.8824011718873;31735.682643173273;32033.839830801164;32098;32132.19669508234;32166.517502237486;1124.2186680257307;1131.1572878205625;1145.238416453066;1147.8163493841112;1210.189173253922;16561.303446075228;17140.742888856676;17144.314227431012;17146.142692865305;17379.304827806747;407026;409730.0269972979;411332;412007;414726;56465;56929.430705693245;56958;57047.42952570504;57052.42947570471;1379.0966916669597;1421.779624158257;1424.7862820576788;1431.398812498753;1437.1951707044088;29909.70090299069;31160.459526581646;31445.371092578476;31892.521612175373;32190.83904580462;49726.75136624438;58895.41104589071;60596.39403605908;61055;61237.693811530655;320690;321622;322602;323152;323788;25404.364890877874;27902.44195116127;28176.577351340155;28443.573346399407;28447.288817778892;45382.31926521039;45661;45676.771616141705;46462.76768616135;46965;37832;38462.42306365463;38921.02697432587;39151.41272880852;39685;38001.23997519979;38117.23765524729;38261.78961605485;38394.23211535698;38395.80802096083;39066.21867562576;39324.606753933236;39704.40443393409;41175;42395.57604423916;31395.84302078475;32464.35071298608;32585.837070814494;32665;33009.83495082509;25919.611205831552;27544.724552754215;27628.585571216045;27672.169834904984;27733.722662773114 04:20:44 INFO - PROCESS | 31600 | |2;jquery.html;397.9900502487437;401.3898873711956;402.5029089074994;407.7044142996328;415.93552999285123;12563.50908885627;18393.908030459846;18830.15264313106;19068.99999999998;19072.04639768011;17872;18326.633467330677;18545.907270463627;18581.721274180898;18745.625087498243;5606.523445507137;5798.246227990377;5808.970955145219;5817.912731309034;5844.064949608063;5725.341585717633;5766.760146568487;5767.36558978512;5772.393898640625;5776.104703770901;4194.2450358935375;6024.939750602482;6387.201599800025;6398.8080357589115;6404.039394090877;5204.4014938281825;5479.150731636602;6335.049742538633;6395.072714456401;6399.26408463028;5308.097623404031;5337.546308563777;5361.195820626898;5363.6245462817615;5364.436734142937;11909;12135.271883687006;12345.5061797528;12387;12412.62762117138;2156.169874598291;2263.920762773295;2389.462370966536;2416.854988700666;2420.382802385398;9249.861252081224;9295.67465138717;9301.162895339385;12261.203021803554;12963.87036129636;1793.623339098791;1812.4109664359137;1872.953176170593;1928.055252926056;1932.2077948041376;68737;70628.40915340537;72528.6373568134;72570.27429725688;73779.99999999946;10822;10919.672409827717;10922.617708380169;10936.671899843017;11059.72350691223;14898.255087245594;15112.924435377972;15120.621984450478;15128.470503532324;15136.243187840564;7920.5247685139075;8053.879191812128;8114.959425202836;8209.917900821034;8237.135100814448;7754.457187996786;7759.418043646749;7765.1458339582605;7839.843203135905;7920.5247685139075;4355.499117601453;4388;4640.164770341371;4699.318598803223;4700.929486057712;1811.7372980917694;1880.0881572437631;1898.7816401114048;1955.7848636649958;1966.4002479243968;983.6508039645822;1009.4448053570653;1029.9897001029894;1032.5250384823066;1087.0814162033068;18129.546761331072;18173.45479635613;18443;19039.90480047591;19097.904510477358;1015.3095894791612;1045.5190612318268;1085.6037546295704;1114.6154576671036;1124.6288724720823;10028.147607453448;10394.896051039394;10417.489464027674;10422.5830966762;10460.320079194827;470827;478348;482336;486763;487150;82240;84117.57941210378;84605.57697211475;87188.56405718057;87830.56084719536;1014.8782146142363;1034.3225187502198;1044.4099084017505;1053.1785207538132;1055.8363453664695;16201.4329498467;16559.172041398124;16635.667286653956;16693.415730449375;16824.07467589294;36042.27915441624;36498;36788.63211367852;37069.81465092765;37203.441948371335;47089.52910470851;48454.515454845;50108.49891501039;51161.48838511567;52291;7783.182765809508;7794.571298578632;7863.252990965849;7887.5267483948855;7898.2891539761695;11412.429378531206;11950.581729639422;12060.276383417024;12284.385780711107;12607.369631518204;10481.42352170638;10884;11042.668719938414;11062.889371106508;11206.271592346471;6371.840703982438;8311.501309921425;10713.196510261605;10938.398388088732;11024.44877756125;10268.743281418025;11291.209615327178;11481.483333250191;11496.310221386744;11597.6520704379;7698.576578288248;7720.884186737091;7840.921590784019;7950.284474397332;8032.799180020546;9368.625254989724;10673.199510036624;10943.398113103538;11152.442377881236;11253.099752019982 04:20:44 INFO - PROCESS | 31600 | |3;mootools.html;1372.0944176843286;1516.340391929511;1551.914644694542;1694.4323651576722;1827.0864567716142;7898.13120556739;8208.425410221287;8217.506949583014;8221.91778082219;8223.62993665285;7983.32141767949;8141.633626486822;8148.10370859205;8153.470024448407;8153.714619988302;2023.7267968824242;2248.8425810193294;2276.3057267533395;2302.1136862307962;2309.145616122037;2300.7814257645496;2315.3285547191376;2318.327684971356;2319.976800231993;2320.1879342230254;2269.954600907981;2331.5686597979343;2332.6734257204007;2333.9416514587188;2334.3347146063375;2012;2224.2659922225707;2266.3654176830514;2269.0356598445596;2269.319204238722;2221.8111460525874;2227.432004838772;2230.710007699005;2231.252530402317;2262.2534563593977;8060.637271322805;8079.070906845671;8119.188081191834;8120.309773669245;8134.471259368122;4698.647601429872;4838.322634831126;4846.975765121152;4854.004928989584;4930.704157750511;3196.3447493263825;3278.3115545735423;3300.059483047344;3357.2278375973665;3367.51171080192;1090.8854570270166;1099.3349023840622;1107.9556817727282;1126.419893754717;1132.7564573616712;11017.779644407066;11068.059214966657;11082.279651822686;11084.944575277072;11093.1125509959;4283.421738065322;4292.227399068135;4453.799579018952;4486.842960496367;4515.661325400608;9293.442393456415;9367.578458969363;9370.718878433658;9378.390404623678;9384.718458446258;4558.179527685049;4974.403071631355;4981.978694367646;4988.027334669705;4989.825356112591;4431.7562534060935;4539.568740969603;4539.909201815945;4572.199865023607;4595.241785105421;3774.75464094833;3782.981085094557;3855.0747820522874;3894.123822139996;3909.6285852844503;1206.1797977375293;1243.322389297835;1247.8689737577606;1253.3232054690548;1258.4714419943646;812.5490352854223;849.6320080992997;850.4897061763016;939.4269495607674;943.6980166346704;5521.806736764194;5630.5495560355075;5632.352279487829;5723.627964182315;5840;874.3180319350917;915.2494954137676;951.5527701980196;951.9381240219363;1009.4094954451728;3888.375346641006;3948.940765888514;3958.8614398495915;3978.42312864633;4064.9593504065174;9942.403455792675;10051.195904327637;10061.094501494901;10270.281080324306;10408.271421000458;10165.796684066278;10219.897801021894;10229;10249.9487502562;10259.333143345659;7625.8856117157175;7647.120581133241;7699.923000770144;7815.140334563193;7827.412944029106;5574.191742197439;5574.247476590608;5575.609707320448;5675.848430977081;5704.771809127588;9031.864522032307;9065.592048357708;9240.122188392092;9288.164065234161;9348.298877584073;8941.390549701116;9247.352685311964;9255.537223138681;9277.6288948444;9296.535173241446;6686;6991.300869912968;7129.073220481304;7137.714491420285;7243.275672432715;7712.730054448068;7797.92202077972;7800.804979875322;7828.686852525835;7851.568163751049;6928.653567321715;7009.404200642798;7042.859142817218;7124;7174.605396703231;6962.373386395248;6992.965035174791;7048.647567621496;7155.069840920647;7195.8560828784175;6327.177466929454;6521.054447105048;6521.64130972801;6531.3468653134305;6714.664266786739;4848.200046992207;4954;5011.974940125276;5028.120078986236;5035.521625445577;5012.323336349692;5040.798368065236;5052.317937078447;5054.039732450822;5084.51697088776 04:20:44 INFO - PROCESS | 31600 | |4;prototype.html;338.87461639193504;339.5263607267861;347.71313666225365;348.4129242226848;349.3327744008943;5571.860703482415;5631.943680563193;5675.155574438303;5675.3757086720425;5690.857728556788;5527.115661494162;5552.805651802188;5567.610267281292;5586.608937374385;5646.520045796112;3895.162540053888;4133.896652583687;4242.6605871530355;4275.080857615612;4299.914001719963;4261.3607958806115;4277.764722940237;4290.377895205193;4290.377895205193;4292.356146578023;4253.8723838284905;4261.296886013804;4277.358396240557;4279.165562715271;4292.549282325358;4145.937810932838;4222.282212023948;4339.826406943718;4346;4351.0645211279725;3813.866514671973;3834.3481608126685;3845.750026248285;3862.4013277941963;3870.2066076454257;5315.441878602768;5319.867003324909;5360.3299587551555;5378.757955891994;5385.407605163468;4896.363472748555;5021.221710634821;5033.320501732256;5053.343065401511;5055.165897626887;5781.19063331134;5811.389804070554;5825.825225243249;5828.737706803204;5843;4240.809163587615;4244.533101358848;4248.362745588187;4256.765877876715;4258.87223383299;5848.356680765112;5875.500582450497;5984.371640977722;6148.108524264001;6151.6001459904965;4349.325854492558;4362.345648152803;4369.71596846204;4378.540253273424;4385.144896745104;4419.911601767946;4427.232979387883;4427.734335939854;4431.822727090945;4438.423005009328;4890.315355850184;4917.655764096479;4993.775280112403;5001.424836143818;5025.070361983045;5765.942340576625;5832.270966129234;5855.151003104611;5855.560832937546;5882.647041177543;1523.3754160794022;1546.8707843274472;1550.3101120001716;1551.5190291009824;1554.7201503729211;1023.5752162852333;1058.3385384134915;1061.5382308695587;1064.3188359449957;1071.4053700196466;5678.488935995781;5688.435680187981;5695;5702.344230413472;5703.686297253691;6045.395460453919;6070.119832624245;6081.7871374502565;6087.239095113111;6091.116788065706;5483.259759932358;5648.604597678205;5674.631148975303;5684.744186511617;5722.4277572242445;3202.615686117634;3210.5184222366834;3215.5658986036588;3221.3557288542384;3221.4201443739885;6139.416755408229;6280.340564240781;6299.149614801943;6318.778842740482;6452.161219041494;6273.37266273369;6309.968450157811;6328.11406403104;6349.873002539924;6351.301356850743;6237.4698150657705;6385.233771947396;6427.839304017437;6448.161738973903;6456.451201647913;6085.786997455068;6145.9692701536205;6175.197224360804;6175.2589689237575;6202.255729312511;6015.4586087252355;6068.757249709962;6075.787347442818;6086.452219300284;6120.693965301628;5889.204957330877;6009.462855544211;6248.4376406123665;6369.20384951881;6370.554061215856;4253.851115210953;4266.743995360288;4272.081502476983;4281.871543853689;4285.507166675872;6043.728032238472;6099.786507472217;6148.385161483816;6150.876982460236;6170.290416602148;5942.435468630473;5963.9105413417965;5986.9401305986385;5990.880182396415;6002.879942401215;5935.287765467999;5970.432808883149;5972.522198224218;5975.581709280309;5989.760409583742;5567.69377684215;5854.180414742024;5870.090136028923;5886.676232807236;5899.115132730125;5957.225560677084;5997.370276120944;6028.638281703112;6032.4570788629235;6052.911745447814;5657.2928383952;5860.970695146497;5876.1773351729935;5877.177195192762;5926.911096333644 04:20:44 INFO - PROCESS | 31600 | |5;yui.html;814.9405772495755;819.7049062337558;827.8096037911284;841.6465084664441;853.748144297432;12545.623631291064;12664.303463309514;12834.935825320883;12836.743265134715;12844.807327890088;12442.129050966436;12480.063995200351;12651.430685619147;12653.240805551673;12662.24026558407;680.2958937499664;791.5211297165218;815.922487363701;828.1428721273484;828.4697793412221;814.0353680888137;824.5217773691245;824.789678631948;825.7110011495988;825.7233826668073;851.1148405658108;852.1223140165608;853.1809462915609;853.2107800284742;854.1117238072397;704.6828926982853;839.4040231435688;848.4018766769412;852.3309202276214;862.2929198057595;629.8645791154923;630.0077378129464;630.0643544336656;630.2468550082654;630.5082036011918;12988.480460781651;12992;13061.542846000439;13063.869361306455;13067.934660326733;13684.93157534216;13889.722205555832;13969.860301397059;14006.22965736884;14529;10839.891601083968;10927.398993055378;11030.944845275802;11673.591424300193;11743.119266054995;4488;4525.456945166568;4649.86050418488;4708.529147085298;4743.620510359197;56627.71686141584;56977.71511142459;57497.425025749624;57505;57784.71107644477;10456.058954693963;10532.210084243712;10882.564697412015;10931.672049838518;11211.103111751041;19186.712199317022;19204;19210.423687289403;19233.134508947132;19242.422727318204;7751.302382785577;7752;8033.959830200812;8052.959735201286;8079.798005049921;4621.2837010263465;4675.275332323496;4687.882802929886;4692.788824502905;4815.494373090845;3141.104785136225;3213.3252017076206;3219.4687876500116;3219.4687876500584;3220.5330227117406;536.8657835541114;554.9028919938994;559.5355854640638;612.8958077126899;647.889858724018;694.5693669924578;738.9519681220811;766.180187199691;769.4806005946076;807.11620775251;9245.167934885892;9260.305477089245;9368;9673.467959262167;9745.673859426632;611.1535523300261;638.256431257589;743.4387037786437;782.1396463889789;784.4038530716697;4527.569880861313;4578.40480737502;4592.338776142218;4597.44830620321;4639.072185562901;63365.683171584766;63743;64520;64619.676901616134;66192.66903665451;54426.18360724593;54500.18249726258;54727.452725472234;55815.720921395136;56349;48809.46448327133;49254.50745492571;49522.009559808605;49974.500254997714;50301;8300.252977231836;8385.28725058377;8416.83166336682;8668.609912553824;8688.13118688126;32141.517877231392;32344.514832278004;32845.835770820995;32971.340573188885;33649.15877103092;38665.80667096646;39487.2102557953;39496.40755388614;40217.59782402255;41475.1704965905;11730.413479325829;11738.119641027128;11890.76218475643;12045.33750643723;12216.572419965258;13217;13294.800577991531;13537.052406331462;13793.172409655454;14465.059771114844;12641.747165056831;12661.240325580495;12892.548760793326;13265.734685306046;13309.600711978655;11252.324860508068;11640.94179529097;11662;11680.94159529197;12680.6829829255;12543.754972155853;12684.112112152061;13063.804042939173;13270.80093798613;13285.13646612967;9942.502874856084;10097.596096156072;10315.12321452685;10780.838287425851;10930.453477325942;10510.369377837049;10683.145348372267;10919.617813376493;10994.610093461602;11021.173411993972 04:20:44 INFO - PROCESS | 31600 | __end_tp_report 04:20:44 INFO - PROCESS | 31600 | __start_cc_report 04:20:44 INFO - PROCESS | 31600 | _x_x_mozilla_cycle_collect,754 04:20:44 INFO - PROCESS | 31600 | __end_cc_report 04:20:44 INFO - PROCESS | 31600 | __startTimestamp1460978444808__endTimestamp 04:20:44 INFO - PROCESS | 31600 | 04:20:44 INFO - PROCESS | 31600 | ------- Summary: start ------- 04:20:44 INFO - PROCESS | 31600 | Number of tests: 6 04:20:44 INFO - PROCESS | 31600 | 04:20:44 INFO - PROCESS | 31600 | [#0] dojo.html Cycles:165 Average:5144.83 Median:5350.68 stddev:566.67 (10.6%) stddev-sans-first:543.15 04:20:44 INFO - PROCESS | 31600 | Values: 3012.3 3057.6 3090.0 3091.1 3113.9 5067.5 5164.2 5179.5 5230.5 5230.7 5198.7 5216.0 5218.3 5238.7 5276.4 4632.7 4683.1 4772.1 4821.8 4837.1 4774.6 4791.3 4815.8 4821.7 4881.6 4650.6 4708.6 4750.6 4794.0 4796.6 4695.8 4726.4 4730.7 4743.3 4787.2 4679.8 4703.7 4718.7 4732.1 4739.4 5039.7 5117.8 5160.1 5190.8 5193.3 5477.2 5484.9 5487.5 5489.0 5491.2 5448.2 5530.9 5534.9 5536.7 5540.6 5151.3 5155.2 5178.9 5193.4 5219.6 5615.1 5622.9 5626.1 5627.6 5667.2 5362.0 5416.6 5420.6 5424.4 5466.3 5545.2 5562.3 5572.2 5574.3 5618.3 5543.8 5554.5 5556.1 5557.8 5566.2 5368.3 5442.8 5501.6 5551.8 5615.6 4182.8 4184.4 4185.1 4220.5 4224.2 3765.3 3768.8 3768.8 3800.4 3802.9 5145.2 5238.8 5264.6 5281.6 5333.2 5482.7 5486.9 5489.9 5505.7 5558.8 5197.3 5200.0 5201.3 5215.3 5247.4 4674.1 4757.0 4766.4 4801.3 4829.5 5698.3 5704.9 5706.5 5708.0 5720.0 5516.3 5525.6 5534.4 5537.2 5574.7 5628.3 5691.0 5700.5 5737.5 5751.4 5426.2 5430.3 5431.8 5435.0 5445.3 5381.1 5528.0 5530.8 5531.5 5581.9 5398.3 5435.2 5436.3 5437.2 5480.7 5371.4 5372.7 5384.3 5389.2 5392.6 5166.9 5313.8 5322.7 5339.5 5350.7 5451.4 5457.7 5467.1 5468.6 5505.2 5343.6 5347.8 5348.4 5351.1 5352.9 04:20:44 INFO - PROCESS | 31600 | 04:20:44 INFO - PROCESS | 31600 | [#1] ext.html Cycles:180 Average:51335.68 Median:32813.43 stddev:90507.29 (275.8%) stddev-sans-first:90681.04 04:20:44 INFO - PROCESS | 31600 | Values: 603.7 637.2 638.6 656.6 674.1 30139.2 36992.0 37778.0 37889.0 38030.4 40277.0 40792.4 40937.6 40944.4 41030.8 7641.1 8478.0 8684.1 8690.7 9845.0 9860.4 10038.6 10040.5 10042.8 10047.4 10055.8 10114.5 10123.3 10128.9 10135.1 7841.5 9982.5 10051.8 10235.1 10642.7 10055.9 10186.2 10202.3 10215.9 10222.6 36861.3 37452.2 37456.3 37500.4 37522.2 3545.1 3629.2 3632.1 3786.0 3866.6 32048.4 32419.5 32556.7 32777.5 32849.3 4279.7 4359.4 4394.3 4394.6 4394.7 287086.0 288296.0 288895.0 289451.0 289801.0 56035.0 56866.0 56996.7 57103.7 57117.4 60961.4 61184.0 61223.0 61274.4 61349.4 16398.7 16914.4 16945.7 16958.7 16979.1 12906.2 12974.7 12982.2 13004.7 13006.0 17026.0 17285.8 17538.7 17663.2 17667.3 5433.6 6427.6 6533.4 6605.0 6796.5 1055.5 1141.7 1146.0 1186.2 1237.9 31735.7 32033.8 32098.0 32132.2 32166.5 1124.2 1131.2 1145.2 1147.8 1210.2 16561.3 17140.7 17144.3 17146.1 17379.3 407026.0 409730.0 411332.0 412007.0 414726.0 56465.0 56929.4 56958.0 57047.4 57052.4 1379.1 1421.8 1424.8 1431.4 1437.2 29909.7 31160.5 31445.4 31892.5 32190.8 49726.8 58895.4 60596.4 61055.0 61237.7 320690.0 321622.0 322602.0 323152.0 323788.0 25404.4 27902.4 28176.6 28443.6 28447.3 45382.3 45661.0 45676.8 46462.8 46965.0 37832.0 38462.4 38921.0 39151.4 39685.0 38001.2 38117.2 38261.8 38394.2 38395.8 39066.2 39324.6 39704.4 41175.0 42395.6 31395.8 32464.4 32585.8 32665.0 33009.8 25919.6 27544.7 27628.6 27672.2 27733.7 04:20:44 INFO - PROCESS | 31600 | 04:20:44 INFO - PROCESS | 31600 | [#2] jquery.html Cycles:180 Average:27326.68 Median:2403.16 stddev:79079.25 (3290.6%) stddev-sans-first:79275.24 04:20:44 INFO - PROCESS | 31600 | Values: 398.0 401.4 402.5 407.7 415.9 12563.5 18393.9 18830.2 19069.0 19072.0 17872.0 18326.6 18545.9 18581.7 18745.6 5606.5 5798.2 5809.0 5817.9 5844.1 5725.3 5766.8 5767.4 5772.4 5776.1 4194.2 6024.9 6387.2 6398.8 6404.0 5204.4 5479.2 6335.0 6395.1 6399.3 5308.1 5337.5 5361.2 5363.6 5364.4 11909.0 12135.3 12345.5 12387.0 12412.6 2156.2 2263.9 2389.5 2416.9 2420.4 9249.9 9295.7 9301.2 12261.2 12963.9 1793.6 1812.4 1873.0 1928.1 1932.2 68737.0 70628.4 72528.6 72570.3 73780.0 10822.0 10919.7 10922.6 10936.7 11059.7 14898.3 15112.9 15120.6 15128.5 15136.2 7920.5 8053.9 8115.0 8209.9 8237.1 7754.5 7759.4 7765.1 7839.8 7920.5 4355.5 4388.0 4640.2 4699.3 4700.9 1811.7 1880.1 1898.8 1955.8 1966.4 983.7 1009.4 1030.0 1032.5 1087.1 18129.5 18173.5 18443.0 19039.9 19097.9 1015.3 1045.5 1085.6 1114.6 1124.6 10028.1 10394.9 10417.5 10422.6 10460.3 470827.0 478348.0 482336.0 486763.0 487150.0 82240.0 84117.6 84605.6 87188.6 87830.6 1014.9 1034.3 1044.4 1053.2 1055.8 16201.4 16559.2 16635.7 16693.4 16824.1 36042.3 36498.0 36788.6 37069.8 37203.4 47089.5 48454.5 50108.5 51161.5 52291.0 7783.2 7794.6 7863.3 7887.5 7898.3 11412.4 11950.6 12060.3 12284.4 12607.4 10481.4 10884.0 11042.7 11062.9 11206.3 6371.8 8311.5 10713.2 10938.4 11024.4 10268.7 11291.2 11481.5 11496.3 11597.7 7698.6 7720.9 7840.9 7950.3 8032.8 9368.6 10673.2 10943.4 11152.4 11253.1 04:20:44 INFO - PROCESS | 31600 | 04:20:44 INFO - PROCESS | 31600 | [#3] mootools.html Cycles:180 Average:5415.44 Median:4988.93 stddev:2975.84 (59.6%) stddev-sans-first:2968.68 04:20:44 INFO - PROCESS | 31600 | Values: 1372.1 1516.3 1551.9 1694.4 1827.1 7898.1 8208.4 8217.5 8221.9 8223.6 7983.3 8141.6 8148.1 8153.5 8153.7 2023.7 2248.8 2276.3 2302.1 2309.1 2300.8 2315.3 2318.3 2320.0 2320.2 2270.0 2331.6 2332.7 2333.9 2334.3 2012.0 2224.3 2266.4 2269.0 2269.3 2221.8 2227.4 2230.7 2231.3 2262.3 8060.6 8079.1 8119.2 8120.3 8134.5 4698.6 4838.3 4847.0 4854.0 4930.7 3196.3 3278.3 3300.1 3357.2 3367.5 1090.9 1099.3 1108.0 1126.4 1132.8 11017.8 11068.1 11082.3 11084.9 11093.1 4283.4 4292.2 4453.8 4486.8 4515.7 9293.4 9367.6 9370.7 9378.4 9384.7 4558.2 4974.4 4982.0 4988.0 4989.8 4431.8 4539.6 4539.9 4572.2 4595.2 3774.8 3783.0 3855.1 3894.1 3909.6 1206.2 1243.3 1247.9 1253.3 1258.5 812.5 849.6 850.5 939.4 943.7 5521.8 5630.5 5632.4 5723.6 5840.0 874.3 915.2 951.6 951.9 1009.4 3888.4 3948.9 3958.9 3978.4 4065.0 9942.4 10051.2 10061.1 10270.3 10408.3 10165.8 10219.9 10229.0 10249.9 10259.3 7625.9 7647.1 7699.9 7815.1 7827.4 5574.2 5574.2 5575.6 5675.8 5704.8 9031.9 9065.6 9240.1 9288.2 9348.3 8941.4 9247.4 9255.5 9277.6 9296.5 6686.0 6991.3 7129.1 7137.7 7243.3 7712.7 7797.9 7800.8 7828.7 7851.6 6928.7 7009.4 7042.9 7124.0 7174.6 6962.4 6993.0 7048.6 7155.1 7195.9 6327.2 6521.1 6521.6 6531.3 6714.7 4848.2 4954.0 5012.0 5028.1 5035.5 5012.3 5040.8 5052.3 5054.0 5084.5 04:20:44 INFO - PROCESS | 31600 | 04:20:44 INFO - PROCESS | 31600 | [#4] prototype.html Cycles:180 Average:4975.34 Median:5665.96 stddev:1475.92 (26.0%) stddev-sans-first:1438.45 04:20:44 INFO - PROCESS | 31600 | Values: 338.9 339.5 347.7 348.4 349.3 5571.9 5631.9 5675.2 5675.4 5690.9 5527.1 5552.8 5567.6 5586.6 5646.5 3895.2 4133.9 4242.7 4275.1 4299.9 4261.4 4277.8 4290.4 4290.4 4292.4 4253.9 4261.3 4277.4 4279.2 4292.5 4145.9 4222.3 4339.8 4346.0 4351.1 3813.9 3834.3 3845.8 3862.4 3870.2 5315.4 5319.9 5360.3 5378.8 5385.4 4896.4 5021.2 5033.3 5053.3 5055.2 5781.2 5811.4 5825.8 5828.7 5843.0 4240.8 4244.5 4248.4 4256.8 4258.9 5848.4 5875.5 5984.4 6148.1 6151.6 4349.3 4362.3 4369.7 4378.5 4385.1 4419.9 4427.2 4427.7 4431.8 4438.4 4890.3 4917.7 4993.8 5001.4 5025.1 5765.9 5832.3 5855.2 5855.6 5882.6 1523.4 1546.9 1550.3 1551.5 1554.7 1023.6 1058.3 1061.5 1064.3 1071.4 5678.5 5688.4 5695.0 5702.3 5703.7 6045.4 6070.1 6081.8 6087.2 6091.1 5483.3 5648.6 5674.6 5684.7 5722.4 3202.6 3210.5 3215.6 3221.4 3221.4 6139.4 6280.3 6299.1 6318.8 6452.2 6273.4 6310.0 6328.1 6349.9 6351.3 6237.5 6385.2 6427.8 6448.2 6456.5 6085.8 6146.0 6175.2 6175.3 6202.3 6015.5 6068.8 6075.8 6086.5 6120.7 5889.2 6009.5 6248.4 6369.2 6370.6 4253.9 4266.7 4272.1 4281.9 4285.5 6043.7 6099.8 6148.4 6150.9 6170.3 5942.4 5963.9 5986.9 5990.9 6002.9 5935.3 5970.4 5972.5 5975.6 5989.8 5567.7 5854.2 5870.1 5886.7 5899.1 5957.2 5997.4 6028.6 6032.5 6052.9 5657.3 5861.0 5876.2 5877.2 5926.9 04:20:44 INFO - PROCESS | 31600 | 04:20:44 INFO - PROCESS | 31600 | [#5] yui.html Cycles:180 Average:14642.26 Median:4630.18 stddev:17145.48 (370.3%) stddev-sans-first:17162.13 04:20:44 INFO - PROCESS | 31600 | Values: 814.9 819.7 827.8 841.6 853.7 12545.6 12664.3 12834.9 12836.7 12844.8 12442.1 12480.1 12651.4 12653.2 12662.2 680.3 791.5 815.9 828.1 828.5 814.0 824.5 824.8 825.7 825.7 851.1 852.1 853.2 853.2 854.1 704.7 839.4 848.4 852.3 862.3 629.9 630.0 630.1 630.2 630.5 12988.5 12992.0 13061.5 13063.9 13067.9 13684.9 13889.7 13969.9 14006.2 14529.0 10839.9 10927.4 11030.9 11673.6 11743.1 4488.0 4525.5 4649.9 4708.5 4743.6 56627.7 56977.7 57497.4 57505.0 57784.7 10456.1 10532.2 10882.6 10931.7 11211.1 19186.7 19204.0 19210.4 19233.1 19242.4 7751.3 7752.0 8034.0 8053.0 8079.8 4621.3 4675.3 4687.9 4692.8 4815.5 3141.1 3213.3 3219.5 3219.5 3220.5 536.9 554.9 559.5 612.9 647.9 694.6 739.0 766.2 769.5 807.1 9245.2 9260.3 9368.0 9673.5 9745.7 611.2 638.3 743.4 782.1 784.4 4527.6 4578.4 4592.3 4597.4 4639.1 63365.7 63743.0 64520.0 64619.7 66192.7 54426.2 54500.2 54727.5 55815.7 56349.0 48809.5 49254.5 49522.0 49974.5 50301.0 8300.3 8385.3 8416.8 8668.6 8688.1 32141.5 32344.5 32845.8 32971.3 33649.2 38665.8 39487.2 39496.4 40217.6 41475.2 11730.4 11738.1 11890.8 12045.3 12216.6 13217.0 13294.8 13537.1 13793.2 14465.1 12641.7 12661.2 12892.5 13265.7 13309.6 11252.3 11640.9 11662.0 11680.9 12680.7 12543.8 12684.1 13063.8 13270.8 13285.1 9942.5 10097.6 10315.1 10780.8 10930.5 10510.4 10683.1 10919.6 10994.6 11021.2 04:20:44 INFO - PROCESS | 31600 | -------- Summary: end -------- 04:20:44 INFO - PROCESS | 31600 | 04:20:45 INFO - TEST-INFO | 31600: exit 0 04:20:45 INFO - TEST-OK | dromaeo_css | took 1111328ms 04:20:45 INFO - TEST-START | kraken 04:20:45 INFO - operating with platform_type : linux_ 04:20:45 INFO - Initialising browser for kraken test... 04:20:45 INFO - TEST-INFO | started process 31783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBKobYp/profile http://localhost:59924/getInfo.html) 04:20:49 INFO - PROCESS | 31783 | __metrics Screen width/height:1600/1200 04:20:49 INFO - PROCESS | 31783 | colorDepth:24 04:20:49 INFO - PROCESS | 31783 | Browser inner width/height: 1024/697 04:20:49 INFO - PROCESS | 31783 | __metrics 04:20:50 ERROR - PROCESS | 31783 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:51 INFO - TEST-INFO | 31783: exit 0 04:20:51 INFO - Browser initialized. 04:20:51 INFO - Running cycle 1/1 for kraken test... 04:20:51 INFO - TEST-INFO | started process 31866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBKobYp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:03 INFO - PROCESS | 31866 | RSS: Main: 152391680 04:21:03 INFO - PROCESS | 31866 | 04:21:05 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59924/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:06 INFO - PROCESS | 31866 | RSS: Main: 208560128 04:21:06 INFO - PROCESS | 31866 | 04:21:09 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59924/tests/kraken/driver.html?testName=audio-dft) 04:21:09 INFO - PROCESS | 31866 | RSS: Main: 193675264 04:21:09 INFO - PROCESS | 31866 | 04:21:12 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59924/tests/kraken/driver.html?testName=audio-fft) 04:21:13 INFO - PROCESS | 31866 | RSS: Main: 265584640 04:21:13 INFO - PROCESS | 31866 | 04:21:15 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59924/tests/kraken/driver.html?testName=audio-oscillator) 04:21:16 INFO - PROCESS | 31866 | RSS: Main: 173023232 04:21:16 INFO - PROCESS | 31866 | 04:21:18 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59924/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:18 INFO - PROCESS | 31866 | RSS: Main: 176971776 04:21:18 INFO - PROCESS | 31866 | 04:21:21 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59924/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:22 INFO - PROCESS | 31866 | RSS: Main: 213098496 04:21:22 INFO - PROCESS | 31866 | 04:21:25 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59924/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:26 INFO - PROCESS | 31866 | RSS: Main: 213454848 04:21:26 INFO - PROCESS | 31866 | 04:21:29 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59924/tests/kraken/driver.html?testName=json-parse-financial) 04:21:29 INFO - PROCESS | 31866 | RSS: Main: 213516288 04:21:29 INFO - PROCESS | 31866 | 04:21:31 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59924/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:31 INFO - PROCESS | 31866 | RSS: Main: 200863744 04:21:31 INFO - PROCESS | 31866 | 04:21:33 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59924/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:34 INFO - PROCESS | 31866 | RSS: Main: 203251712 04:21:34 INFO - PROCESS | 31866 | 04:21:36 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59924/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:36 INFO - PROCESS | 31866 | RSS: Main: 217391104 04:21:36 INFO - PROCESS | 31866 | 04:21:39 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:40 INFO - PROCESS | 31866 | RSS: Main: 222543872 04:21:40 INFO - PROCESS | 31866 | 04:21:42 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:43 INFO - PROCESS | 31866 | RSS: Main: 220733440 04:21:43 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:59924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59924/tests/kraken/driver.html?testName=ai-astar) 04:21:45 INFO - PROCESS | 31866 | RSS: Main: 284180480 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | __start_tp_report 04:21:45 INFO - PROCESS | 31866 | _x_x_mozilla_page_load 04:21:45 INFO - PROCESS | 31866 | _x_x_mozilla_page_load_details 04:21:45 INFO - PROCESS | 31866 | |i|pagename|runs| 04:21:45 INFO - PROCESS | 31866 | |0;ai-astar;109;109;105;109;109;110;100;110;111;110 04:21:45 INFO - PROCESS | 31866 | |1;audio-beat-detection;152;130;162;186;126;156;161;129;182;128 04:21:45 INFO - PROCESS | 31866 | |2;audio-dft;161;160;161;161;162;161;162;163;162;163 04:21:45 INFO - PROCESS | 31866 | |3;audio-fft;79;77;132;104;76;75;76;117;104;73 04:21:45 INFO - PROCESS | 31866 | |4;audio-oscillator;92;92;157;93;92;94;151;92;93;146 04:21:45 INFO - PROCESS | 31866 | |5;imaging-gaussian-blur;116;117;116;116;117;116;117;116;117;116 04:21:45 INFO - PROCESS | 31866 | |6;imaging-darkroom;145;145;146;146;146;145;146;146;145;146 04:21:45 INFO - PROCESS | 31866 | |7;imaging-desaturate;94;94;95;94;95;94;95;94;95;94 04:21:45 INFO - PROCESS | 31866 | |8;json-parse-financial;57;56;57;57;58;58;61;75;55;55 04:21:45 INFO - PROCESS | 31866 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;61;62;61 04:21:45 INFO - PROCESS | 31866 | |10;stanford-crypto-aes;75;76;76;75;77;76;77;78;79;79 04:21:45 INFO - PROCESS | 31866 | |11;stanford-crypto-ccm;128;126;123;130;123;123;125;124;154;124 04:21:45 INFO - PROCESS | 31866 | |12;stanford-crypto-pbkdf2;169;163;163;165;162;162;170;167;165;161 04:21:45 INFO - PROCESS | 31866 | |13;stanford-crypto-sha256-iterative;69;68;67;67;68;75;68;64;68;65 04:21:45 INFO - PROCESS | 31866 | __end_tp_report 04:21:45 INFO - PROCESS | 31866 | __start_cc_report 04:21:45 INFO - PROCESS | 31866 | _x_x_mozilla_cycle_collect,1624 04:21:45 INFO - PROCESS | 31866 | __end_cc_report 04:21:45 INFO - PROCESS | 31866 | __startTimestamp1460978505314__endTimestamp 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | ------- Summary: start ------- 04:21:45 INFO - PROCESS | 31866 | Number of tests: 14 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.50 stddev:3.29 (3.0%) stddev-sans-first:3.48 04:21:45 INFO - PROCESS | 31866 | Values: 109.0 109.0 105.0 109.0 109.0 110.0 100.0 110.0 111.0 110.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:158.50 stddev:22.39 (14.1%) stddev-sans-first:23.75 04:21:45 INFO - PROCESS | 31866 | Values: 152.0 130.0 162.0 186.0 126.0 156.0 161.0 129.0 182.0 128.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 04:21:45 INFO - PROCESS | 31866 | Values: 161.0 160.0 161.0 161.0 162.0 161.0 162.0 163.0 162.0 163.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#3] audio-fft Cycles:10 Average:91.30 Median:75.50 stddev:21.25 (28.1%) stddev-sans-first:22.07 04:21:45 INFO - PROCESS | 31866 | Values: 79.0 77.0 132.0 104.0 76.0 75.0 76.0 117.0 104.0 73.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.00 stddev:28.51 (31.0%) stddev-sans-first:29.47 04:21:45 INFO - PROCESS | 31866 | Values: 92.0 92.0 157.0 93.0 92.0 94.0 151.0 92.0 93.0 146.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:21:45 INFO - PROCESS | 31866 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:21:45 INFO - PROCESS | 31866 | Values: 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:21:45 INFO - PROCESS | 31866 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:57.50 stddev:5.92 (10.3%) stddev-sans-first:6.23 04:21:45 INFO - PROCESS | 31866 | Values: 57.0 56.0 57.0 57.0 58.0 58.0 61.0 75.0 55.0 55.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:21:45 INFO - PROCESS | 31866 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.00 stddev:1.48 (1.9%) stddev-sans-first:1.41 04:21:45 INFO - PROCESS | 31866 | Values: 75.0 76.0 76.0 75.0 77.0 76.0 77.0 78.0 79.0 79.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:125.50 stddev:9.43 (7.5%) stddev-sans-first:10.00 04:21:45 INFO - PROCESS | 31866 | Values: 128.0 126.0 123.0 130.0 123.0 123.0 125.0 124.0 154.0 124.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:3.09 (1.9%) stddev-sans-first:2.86 04:21:45 INFO - PROCESS | 31866 | Values: 169.0 163.0 163.0 165.0 162.0 162.0 170.0 167.0 165.0 161.0 04:21:45 INFO - PROCESS | 31866 | 04:21:45 INFO - PROCESS | 31866 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.92 (4.3%) stddev-sans-first:3.07 04:21:45 INFO - PROCESS | 31866 | Values: 69.0 68.0 67.0 67.0 68.0 75.0 68.0 64.0 68.0 65.0 04:21:45 INFO - PROCESS | 31866 | -------- Summary: end -------- 04:21:45 INFO - PROCESS | 31866 | 04:21:46 INFO - TEST-INFO | 31866: exit 0 04:21:46 INFO - TEST-OK | kraken | took 60804ms 04:21:46 INFO - SUITE-END | took 1172s 04:21:46 INFO - Completed test suite (00:19:32) 04:21:46 INFO - javascript benchmark 04:21:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3012.2619958110267, 3057.55665428513, 3090.0420869530462, 3091.1190310761435, 3113.875444982201, 5067.467915868836, 5164.225366195073, 5179.533841954223, 5230.503102205289, 5230.712310822908, 5198.6880787152795, 5216.0, 5218.32161818963, 5238.738063096849, 5276.419593844674, 4632.722036677793, 4683.133620280242, 4772.093302272575, 4821.807127714887, 4837.105135549935, 4774.570288674018, 4791.305260737191, 4815.807367705288, 4821.710697358169, 4881.585065269456, 4650.581447669709, 4708.552687494683, 4750.643701722384, 4793.976030119827, 4796.592289655384, 4695.765211739399, 4726.385569875929, 4730.668853180278, 4743.288506723985, 4787.234042553209, 4679.789409476582, 4703.6942598730975, 4718.740469274188, 4732.124556956974, 4739.36018637483, 5039.72281524516, 5117.795288188468, 5160.122779127557, 5190.792368305263, 5193.324867767204, 5477.20580515823, 5484.945150548523, 5487.533559647435, 5488.9725551372385, 5491.203775452537, 5448.182772584105, 5530.861728456781, 5534.889302213974, 5536.723163841792, 5540.612157149001, 5151.330327057459, 5155.226715992593, 5178.948210517922, 5193.402758682762, 5219.556337711261, 5615.101583746581, 5622.85942851432, 5626.099824028136, 5627.634203776742, 5667.234923285386, 5361.973190134102, 5416.566674666017, 5420.620556561082, 5424.430434804289, 5466.262054622575, 5545.223668686387, 5562.332520097614, 5572.164175373727, 5574.331080270394, 5618.325800903917, 5543.7782488700805, 5554.472325129106, 5556.083246264402, 5557.805476808292, 5566.192902029264, 5368.302120724281, 5442.809501667422, 5501.642393244426, 5551.750171242304, 5615.578831587647, 4182.769947652848, 4184.3932629768515, 4185.079282557833, 4220.514640816284, 4224.176285624335, 3765.322241996467, 3768.8115594220726, 3768.849246030128, 3800.3729384651224, 3802.9429558556644, 5145.202493613496, 5238.8166414176085, 5264.6051546134195, 5281.577473802086, 5333.200019996954, 5482.725863706799, 5486.945130548644, 5489.945100549024, 5505.6696598204235, 5558.805441809598, 5197.324347834833, 5200.037992971313, 5201.271821944931, 5215.295935048795, 5247.370315562157, 4674.065186962621, 4757.024809914029, 4766.380370551806, 4801.279808028754, 4829.492903245179, 5698.2592263005545, 5704.857378565569, 5706.514946229534, 5708.0, 5719.999000174953, 5516.310461192351, 5525.557955363481, 5534.363548192009, 5537.197106419627, 5574.721263936868, 5628.324601047901, 5690.971545142248, 5700.543956483389, 5737.454941780524, 5751.367349591458, 5426.186072089218, 5430.321209848769, 5431.8098866539485, 5434.972825135849, 5445.292112025411, 5381.1121165007335, 5528.004959107399, 5530.778768849201, 5531.529819965187, 5581.944180558305, 5398.325209348832, 5435.211894275387, 5436.293281873489, 5437.238786569805, 5480.698561578992, 5371.435999220025, 5372.650777699437, 5384.326959130109, 5389.218563308376, 5392.649477783932, 5166.922496162485, 5313.760880760452, 5322.654027488201, 5339.46605339463, 5350.678959262456, 5451.400345962021, 5457.672539647634, 5467.125259958388, 5468.644538105011, 5505.201745746925, 5343.62594618373, 5347.759350829144, 5348.384935732441, 5351.117065684119, 5352.892942141213], "value": 5107.83260665251, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.6649659439013, 637.1939496536885, 638.5593940181275, 656.5830697507084, 674.0798809624863, 30139.24651883701, 36992.0, 37777.99999999996, 37889.0, 38030.42954355687, 40277.0, 40792.38811417824, 40937.59062409375, 40944.38583421251, 41030.794846025725, 7641.121271053817, 8477.95761021194, 8684.131586841297, 8690.695825646071, 9844.950775246114, 9860.359076659994, 10038.648647297347, 10040.548175332127, 10042.84935725961, 10047.397156170617, 10055.849162262572, 10114.544845481934, 10123.341982771133, 10128.949355253213, 10135.138513226384, 7841.490303130278, 9982.50087495626, 10051.798964020678, 10235.130013948823, 10642.680719578426, 10055.949720251425, 10186.185105191567, 10202.285839991204, 10215.89784102157, 10222.591096356211, 36861.262774744624, 37452.19108566841, 37456.25087498235, 37500.43749343762, 37522.24955500902, 3545.1137215696076, 3629.237860049393, 3632.0556655269556, 3785.9621403785886, 3866.5553461352024, 32048.359032819448, 32419.51370729441, 32556.674433255837, 32777.50833737496, 32849.34301313984, 4279.700420970534, 4359.433273674434, 4394.318880573516, 4394.560543945612, 4394.736315821061, 287086.0, 288296.0, 288895.0, 289451.0, 289801.0, 56035.0, 56866.0, 56996.715016424656, 57103.71448142733, 57117.42882571121, 60961.39038609557, 61184.0, 61223.0, 61274.38725612776, 61349.38650613437, 16398.6720265594, 16914.407995720092, 16945.661086778196, 16958.745618815727, 16979.066151361545, 12906.161099528501, 12974.675633109247, 12982.15615984958, 13004.674883127998, 13006.0, 17026.0, 17285.827141728674, 17538.736918946226, 17663.20515576802, 17667.29330826778, 5433.646812957145, 6427.614343139333, 6533.444657204191, 6605.0, 6796.490263230277, 1055.5302890213934, 1141.6509342807424, 1146.0258780037068, 1186.2467333243453, 1237.8824011718873, 31735.682643173273, 32033.839830801164, 32098.0, 32132.19669508234, 32166.517502237486, 1124.2186680257307, 1131.1572878205625, 1145.238416453066, 1147.8163493841112, 1210.189173253922, 16561.303446075228, 17140.742888856676, 17144.314227431012, 17146.142692865305, 17379.304827806747, 407026.0, 409730.0269972979, 411332.0, 412007.0, 414726.0, 56465.0, 56929.430705693245, 56958.0, 57047.42952570504, 57052.42947570471, 1379.0966916669597, 1421.779624158257, 1424.7862820576788, 1431.398812498753, 1437.1951707044088, 29909.70090299069, 31160.459526581646, 31445.371092578476, 31892.521612175373, 32190.83904580462, 49726.75136624438, 58895.41104589071, 60596.39403605908, 61055.0, 61237.693811530655, 320690.0, 321622.0, 322602.0, 323152.0, 323788.0, 25404.364890877874, 27902.44195116127, 28176.577351340155, 28443.573346399407, 28447.288817778892, 45382.31926521039, 45661.0, 45676.771616141705, 46462.76768616135, 46965.0, 37832.0, 38462.42306365463, 38921.02697432587, 39151.41272880852, 39685.0, 38001.23997519979, 38117.23765524729, 38261.78961605485, 38394.23211535698, 38395.80802096083, 39066.21867562576, 39324.606753933236, 39704.40443393409, 41175.0, 42395.57604423916, 31395.84302078475, 32464.35071298608, 32585.837070814494, 32665.0, 33009.83495082509, 25919.611205831552, 27544.724552754215, 27628.585571216045, 27672.169834904984, 27733.722662773114], "value": 19669.868778379983, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.9900502487437, 401.3898873711956, 402.5029089074994, 407.7044142996328, 415.93552999285123, 12563.50908885627, 18393.908030459846, 18830.15264313106, 19068.99999999998, 19072.04639768011, 17872.0, 18326.633467330677, 18545.907270463627, 18581.721274180898, 18745.625087498243, 5606.523445507137, 5798.246227990377, 5808.970955145219, 5817.912731309034, 5844.064949608063, 5725.341585717633, 5766.760146568487, 5767.36558978512, 5772.393898640625, 5776.104703770901, 4194.2450358935375, 6024.939750602482, 6387.201599800025, 6398.8080357589115, 6404.039394090877, 5204.4014938281825, 5479.150731636602, 6335.049742538633, 6395.072714456401, 6399.26408463028, 5308.097623404031, 5337.546308563777, 5361.195820626898, 5363.6245462817615, 5364.436734142937, 11909.0, 12135.271883687006, 12345.5061797528, 12387.0, 12412.62762117138, 2156.169874598291, 2263.920762773295, 2389.462370966536, 2416.854988700666, 2420.382802385398, 9249.861252081224, 9295.67465138717, 9301.162895339385, 12261.203021803554, 12963.87036129636, 1793.623339098791, 1812.4109664359137, 1872.953176170593, 1928.055252926056, 1932.2077948041376, 68737.0, 70628.40915340537, 72528.6373568134, 72570.27429725688, 73779.99999999946, 10822.0, 10919.672409827717, 10922.617708380169, 10936.671899843017, 11059.72350691223, 14898.255087245594, 15112.924435377972, 15120.621984450478, 15128.470503532324, 15136.243187840564, 7920.5247685139075, 8053.879191812128, 8114.959425202836, 8209.917900821034, 8237.135100814448, 7754.457187996786, 7759.418043646749, 7765.1458339582605, 7839.843203135905, 7920.5247685139075, 4355.499117601453, 4388.0, 4640.164770341371, 4699.318598803223, 4700.929486057712, 1811.7372980917694, 1880.0881572437631, 1898.7816401114048, 1955.7848636649958, 1966.4002479243968, 983.6508039645822, 1009.4448053570653, 1029.9897001029894, 1032.5250384823066, 1087.0814162033068, 18129.546761331072, 18173.45479635613, 18443.0, 19039.90480047591, 19097.904510477358, 1015.3095894791612, 1045.5190612318268, 1085.6037546295704, 1114.6154576671036, 1124.6288724720823, 10028.147607453448, 10394.896051039394, 10417.489464027674, 10422.5830966762, 10460.320079194827, 470827.0, 478348.0, 482336.0, 486763.0, 487150.0, 82240.0, 84117.57941210378, 84605.57697211475, 87188.56405718057, 87830.56084719536, 1014.8782146142363, 1034.3225187502198, 1044.4099084017505, 1053.1785207538132, 1055.8363453664695, 16201.4329498467, 16559.172041398124, 16635.667286653956, 16693.415730449375, 16824.07467589294, 36042.27915441624, 36498.0, 36788.63211367852, 37069.81465092765, 37203.441948371335, 47089.52910470851, 48454.515454845, 50108.49891501039, 51161.48838511567, 52291.0, 7783.182765809508, 7794.571298578632, 7863.252990965849, 7887.5267483948855, 7898.2891539761695, 11412.429378531206, 11950.581729639422, 12060.276383417024, 12284.385780711107, 12607.369631518204, 10481.42352170638, 10884.0, 11042.668719938414, 11062.889371106508, 11206.271592346471, 6371.840703982438, 8311.501309921425, 10713.196510261605, 10938.398388088732, 11024.44877756125, 10268.743281418025, 11291.209615327178, 11481.483333250191, 11496.310221386744, 11597.6520704379, 7698.576578288248, 7720.884186737091, 7840.921590784019, 7950.284474397332, 8032.799180020546, 9368.625254989724, 10673.199510036624, 10943.398113103538, 11152.442377881236, 11253.099752019982], "value": 8734.326857624406, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.0944176843286, 1516.340391929511, 1551.914644694542, 1694.4323651576722, 1827.0864567716142, 7898.13120556739, 8208.425410221287, 8217.506949583014, 8221.91778082219, 8223.62993665285, 7983.32141767949, 8141.633626486822, 8148.10370859205, 8153.470024448407, 8153.714619988302, 2023.7267968824242, 2248.8425810193294, 2276.3057267533395, 2302.1136862307962, 2309.145616122037, 2300.7814257645496, 2315.3285547191376, 2318.327684971356, 2319.976800231993, 2320.1879342230254, 2269.954600907981, 2331.5686597979343, 2332.6734257204007, 2333.9416514587188, 2334.3347146063375, 2012.0, 2224.2659922225707, 2266.3654176830514, 2269.0356598445596, 2269.319204238722, 2221.8111460525874, 2227.432004838772, 2230.710007699005, 2231.252530402317, 2262.2534563593977, 8060.637271322805, 8079.070906845671, 8119.188081191834, 8120.309773669245, 8134.471259368122, 4698.647601429872, 4838.322634831126, 4846.975765121152, 4854.004928989584, 4930.704157750511, 3196.3447493263825, 3278.3115545735423, 3300.059483047344, 3357.2278375973665, 3367.51171080192, 1090.8854570270166, 1099.3349023840622, 1107.9556817727282, 1126.419893754717, 1132.7564573616712, 11017.779644407066, 11068.059214966657, 11082.279651822686, 11084.944575277072, 11093.1125509959, 4283.421738065322, 4292.227399068135, 4453.799579018952, 4486.842960496367, 4515.661325400608, 9293.442393456415, 9367.578458969363, 9370.718878433658, 9378.390404623678, 9384.718458446258, 4558.179527685049, 4974.403071631355, 4981.978694367646, 4988.027334669705, 4989.825356112591, 4431.7562534060935, 4539.568740969603, 4539.909201815945, 4572.199865023607, 4595.241785105421, 3774.75464094833, 3782.981085094557, 3855.0747820522874, 3894.123822139996, 3909.6285852844503, 1206.1797977375293, 1243.322389297835, 1247.8689737577606, 1253.3232054690548, 1258.4714419943646, 812.5490352854223, 849.6320080992997, 850.4897061763016, 939.4269495607674, 943.6980166346704, 5521.806736764194, 5630.5495560355075, 5632.352279487829, 5723.627964182315, 5840.0, 874.3180319350917, 915.2494954137676, 951.5527701980196, 951.9381240219363, 1009.4094954451728, 3888.375346641006, 3948.940765888514, 3958.8614398495915, 3978.42312864633, 4064.9593504065174, 9942.403455792675, 10051.195904327637, 10061.094501494901, 10270.281080324306, 10408.271421000458, 10165.796684066278, 10219.897801021894, 10229.0, 10249.9487502562, 10259.333143345659, 7625.8856117157175, 7647.120581133241, 7699.923000770144, 7815.140334563193, 7827.412944029106, 5574.191742197439, 5574.247476590608, 5575.609707320448, 5675.848430977081, 5704.771809127588, 9031.864522032307, 9065.592048357708, 9240.122188392092, 9288.164065234161, 9348.298877584073, 8941.390549701116, 9247.352685311964, 9255.537223138681, 9277.6288948444, 9296.535173241446, 6686.0, 6991.300869912968, 7129.073220481304, 7137.714491420285, 7243.275672432715, 7712.730054448068, 7797.92202077972, 7800.804979875322, 7828.686852525835, 7851.568163751049, 6928.653567321715, 7009.404200642798, 7042.859142817218, 7124.0, 7174.605396703231, 6962.373386395248, 6992.965035174791, 7048.647567621496, 7155.069840920647, 7195.8560828784175, 6327.177466929454, 6521.054447105048, 6521.64130972801, 6531.3468653134305, 6714.664266786739, 4848.200046992207, 4954.0, 5011.974940125276, 5028.120078986236, 5035.521625445577, 5012.323336349692, 5040.798368065236, 5052.317937078447, 5054.039732450822, 5084.51697088776], "value": 4393.399412725303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.87461639193504, 339.5263607267861, 347.71313666225365, 348.4129242226848, 349.3327744008943, 5571.860703482415, 5631.943680563193, 5675.155574438303, 5675.3757086720425, 5690.857728556788, 5527.115661494162, 5552.805651802188, 5567.610267281292, 5586.608937374385, 5646.520045796112, 3895.162540053888, 4133.896652583687, 4242.6605871530355, 4275.080857615612, 4299.914001719963, 4261.3607958806115, 4277.764722940237, 4290.377895205193, 4290.377895205193, 4292.356146578023, 4253.8723838284905, 4261.296886013804, 4277.358396240557, 4279.165562715271, 4292.549282325358, 4145.937810932838, 4222.282212023948, 4339.826406943718, 4346.0, 4351.0645211279725, 3813.866514671973, 3834.3481608126685, 3845.750026248285, 3862.4013277941963, 3870.2066076454257, 5315.441878602768, 5319.867003324909, 5360.3299587551555, 5378.757955891994, 5385.407605163468, 4896.363472748555, 5021.221710634821, 5033.320501732256, 5053.343065401511, 5055.165897626887, 5781.19063331134, 5811.389804070554, 5825.825225243249, 5828.737706803204, 5843.0, 4240.809163587615, 4244.533101358848, 4248.362745588187, 4256.765877876715, 4258.87223383299, 5848.356680765112, 5875.500582450497, 5984.371640977722, 6148.108524264001, 6151.6001459904965, 4349.325854492558, 4362.345648152803, 4369.71596846204, 4378.540253273424, 4385.144896745104, 4419.911601767946, 4427.232979387883, 4427.734335939854, 4431.822727090945, 4438.423005009328, 4890.315355850184, 4917.655764096479, 4993.775280112403, 5001.424836143818, 5025.070361983045, 5765.942340576625, 5832.270966129234, 5855.151003104611, 5855.560832937546, 5882.647041177543, 1523.3754160794022, 1546.8707843274472, 1550.3101120001716, 1551.5190291009824, 1554.7201503729211, 1023.5752162852333, 1058.3385384134915, 1061.5382308695587, 1064.3188359449957, 1071.4053700196466, 5678.488935995781, 5688.435680187981, 5695.0, 5702.344230413472, 5703.686297253691, 6045.395460453919, 6070.119832624245, 6081.7871374502565, 6087.239095113111, 6091.116788065706, 5483.259759932358, 5648.604597678205, 5674.631148975303, 5684.744186511617, 5722.4277572242445, 3202.615686117634, 3210.5184222366834, 3215.5658986036588, 3221.3557288542384, 3221.4201443739885, 6139.416755408229, 6280.340564240781, 6299.149614801943, 6318.778842740482, 6452.161219041494, 6273.37266273369, 6309.968450157811, 6328.11406403104, 6349.873002539924, 6351.301356850743, 6237.4698150657705, 6385.233771947396, 6427.839304017437, 6448.161738973903, 6456.451201647913, 6085.786997455068, 6145.9692701536205, 6175.197224360804, 6175.2589689237575, 6202.255729312511, 6015.4586087252355, 6068.757249709962, 6075.787347442818, 6086.452219300284, 6120.693965301628, 5889.204957330877, 6009.462855544211, 6248.4376406123665, 6369.20384951881, 6370.554061215856, 4253.851115210953, 4266.743995360288, 4272.081502476983, 4281.871543853689, 4285.507166675872, 6043.728032238472, 6099.786507472217, 6148.385161483816, 6150.876982460236, 6170.290416602148, 5942.435468630473, 5963.9105413417965, 5986.9401305986385, 5990.880182396415, 6002.879942401215, 5935.287765467999, 5970.432808883149, 5972.522198224218, 5975.581709280309, 5989.760409583742, 5567.69377684215, 5854.180414742024, 5870.090136028923, 5886.676232807236, 5899.115132730125, 5957.225560677084, 5997.370276120944, 6028.638281703112, 6032.4570788629235, 6052.911745447814, 5657.2928383952, 5860.970695146497, 5876.1773351729935, 5877.177195192762, 5926.911096333644], "value": 4508.290150369446, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.9405772495755, 819.7049062337558, 827.8096037911284, 841.6465084664441, 853.748144297432, 12545.623631291064, 12664.303463309514, 12834.935825320883, 12836.743265134715, 12844.807327890088, 12442.129050966436, 12480.063995200351, 12651.430685619147, 12653.240805551673, 12662.24026558407, 680.2958937499664, 791.5211297165218, 815.922487363701, 828.1428721273484, 828.4697793412221, 814.0353680888137, 824.5217773691245, 824.789678631948, 825.7110011495988, 825.7233826668073, 851.1148405658108, 852.1223140165608, 853.1809462915609, 853.2107800284742, 854.1117238072397, 704.6828926982853, 839.4040231435688, 848.4018766769412, 852.3309202276214, 862.2929198057595, 629.8645791154923, 630.0077378129464, 630.0643544336656, 630.2468550082654, 630.5082036011918, 12988.480460781651, 12992.0, 13061.542846000439, 13063.869361306455, 13067.934660326733, 13684.93157534216, 13889.722205555832, 13969.860301397059, 14006.22965736884, 14529.0, 10839.891601083968, 10927.398993055378, 11030.944845275802, 11673.591424300193, 11743.119266054995, 4488.0, 4525.456945166568, 4649.86050418488, 4708.529147085298, 4743.620510359197, 56627.71686141584, 56977.71511142459, 57497.425025749624, 57505.0, 57784.71107644477, 10456.058954693963, 10532.210084243712, 10882.564697412015, 10931.672049838518, 11211.103111751041, 19186.712199317022, 19204.0, 19210.423687289403, 19233.134508947132, 19242.422727318204, 7751.302382785577, 7752.0, 8033.959830200812, 8052.959735201286, 8079.798005049921, 4621.2837010263465, 4675.275332323496, 4687.882802929886, 4692.788824502905, 4815.494373090845, 3141.104785136225, 3213.3252017076206, 3219.4687876500116, 3219.4687876500584, 3220.5330227117406, 536.8657835541114, 554.9028919938994, 559.5355854640638, 612.8958077126899, 647.889858724018, 694.5693669924578, 738.9519681220811, 766.180187199691, 769.4806005946076, 807.11620775251, 9245.167934885892, 9260.305477089245, 9368.0, 9673.467959262167, 9745.673859426632, 611.1535523300261, 638.256431257589, 743.4387037786437, 782.1396463889789, 784.4038530716697, 4527.569880861313, 4578.40480737502, 4592.338776142218, 4597.44830620321, 4639.072185562901, 63365.683171584766, 63743.0, 64520.0, 64619.676901616134, 66192.66903665451, 54426.18360724593, 54500.18249726258, 54727.452725472234, 55815.720921395136, 56349.0, 48809.46448327133, 49254.50745492571, 49522.009559808605, 49974.500254997714, 50301.0, 8300.252977231836, 8385.28725058377, 8416.83166336682, 8668.609912553824, 8688.13118688126, 32141.517877231392, 32344.514832278004, 32845.835770820995, 32971.340573188885, 33649.15877103092, 38665.80667096646, 39487.2102557953, 39496.40755388614, 40217.59782402255, 41475.1704965905, 11730.413479325829, 11738.119641027128, 11890.76218475643, 12045.33750643723, 12216.572419965258, 13217.0, 13294.800577991531, 13537.052406331462, 13793.172409655454, 14465.059771114844, 12641.747165056831, 12661.240325580495, 12892.548760793326, 13265.734685306046, 13309.600711978655, 11252.324860508068, 11640.94179529097, 11662.0, 11680.94159529197, 12680.6829829255, 12543.754972155853, 12684.112112152061, 13063.804042939173, 13270.80093798613, 13285.13646612967, 9942.502874856084, 10097.596096156072, 10315.12321452685, 10780.838287425851, 10930.453477325942, 10510.369377837049, 10683.145348372267, 10919.617813376493, 10994.610093461602, 11021.173411993972], "value": 6683.951045669679, "unit": "score"}], "name": "dromaeo_css", "value": 6985.4258234758445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 105.0, 109.0, 109.0, 110.0, 100.0, 110.0, 111.0, 110.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 162.0, 186.0, 126.0, 156.0, 161.0, 129.0, 182.0, 128.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 132.0, 104.0, 76.0, 75.0, 76.0, 117.0, 104.0, 73.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 157.0, 93.0, 92.0, 94.0, 151.0, 92.0, 93.0, 146.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 58.0, 58.0, 61.0, 75.0, 55.0, 55.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 75.0, 77.0, 76.0, 77.0, 78.0, 79.0, 79.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 123.0, 130.0, 123.0, 123.0, 125.0, 124.0, 154.0, 124.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 163.0, 165.0, 162.0, 162.0, 170.0, 167.0, 165.0, 161.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 67.0, 68.0, 75.0, 68.0, 64.0, 68.0, 65.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1536.3, "alertThreshold": 2.0}]} 04:21:46 INFO - Return code: 0 04:21:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:21:46 ERROR - # TBPL SUCCESS # 04:21:46 INFO - Running post-action listener: _resource_record_post_action 04:21:46 INFO - Running post-run listener: _resource_record_post_run 04:21:47 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 534130688; Read time: 0; Write time: 441544 04:21:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244236288; Read time: 0; Write time: 266748 04:21:47 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 289894400; Read time: 0; Write time: 174796 04:21:47 INFO - Running post-run listener: _upload_blobber_files 04:21:47 INFO - Blob upload gear active. 04:21:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:47 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:21:47 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:21:47 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:21:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:49 INFO - (blobuploader) - INFO - Done attempting. 04:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:49 INFO - (blobuploader) - INFO - Done attempting. 04:21:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:49 INFO - Return code: 0 04:21:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/260bace07222f69b9b580a9ff11da9cade7c91edafb792fbaa3ac3d880b041949e42f86a0570bd6a7d0e110b4fd1651279cac3aa5b0bb7a50113c9ab02129abf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13580db8ec9c5769b4ffce25b1c26b2e69d073f57232f868173976df833dc4d2a33c9fd9c954fd90e9ad0174c378a7009f2cd28d40174b34a7f7c40830eeb00e"} 04:21:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:49 INFO - Contents: 04:21:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/260bace07222f69b9b580a9ff11da9cade7c91edafb792fbaa3ac3d880b041949e42f86a0570bd6a7d0e110b4fd1651279cac3aa5b0bb7a50113c9ab02129abf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13580db8ec9c5769b4ffce25b1c26b2e69d073f57232f868173976df833dc4d2a33c9fd9c954fd90e9ad0174c378a7009f2cd28d40174b34a7f7c40830eeb00e"} 04:21:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:49 INFO - Copying logs to upload dir... 04:21:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.280417 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-18 04:21:48.640983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 04:21:48.644492) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828 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/sha512/260bace07222f69b9b580a9ff11da9cade7c91edafb792fbaa3ac3d880b041949e42f86a0570bd6a7d0e110b4fd1651279cac3aa5b0bb7a50113c9ab02129abf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13580db8ec9c5769b4ffce25b1c26b2e69d073f57232f868173976df833dc4d2a33c9fd9c954fd90e9ad0174c378a7009f2cd28d40174b34a7f7c40830eeb00e"} build_url:https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/Po-ZvWqrRHeEazc5_bq08w/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/sha512/260bace07222f69b9b580a9ff11da9cade7c91edafb792fbaa3ac3d880b041949e42f86a0570bd6a7d0e110b4fd1651279cac3aa5b0bb7a50113c9ab02129abf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13580db8ec9c5769b4ffce25b1c26b2e69d073f57232f868173976df833dc4d2a33c9fd9c954fd90e9ad0174c378a7009f2cd28d40174b34a7f7c40830eeb00e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 04:21:48.668700) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:21:48.668993) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460977128.255039-1379044828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:21:48.751913) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 04:21:48.752245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 04:21:48.752541) ========= ========= Total master_lag: 0.18 =========