builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1460761585.82 results: success (0) buildid: 20160415133014 builduid: da4416bdeeee4531b060b39c4ce96a56 revision: 354cb3932e36994d7e772cedba237e9c3c60fe4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:25.821104) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:25.821582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:25.821900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:25.839078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:25.839480) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 16:06:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.5M=0s 2016-04-15 16:06:26 (45.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148527 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:26.100628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:26.101033) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017655 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:26.131659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:26.132027) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 354cb3932e36994d7e772cedba237e9c3c60fe4c --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 354cb3932e36994d7e772cedba237e9c3c60fe4c --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=20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 16:06:26,347 truncating revision to first 12 chars 2016-04-15 16:06:26,347 Setting DEBUG logging. 2016-04-15 16:06:26,347 attempt 1/10 2016-04-15 16:06:26,347 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/354cb3932e36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 16:06:26,695 unpacking tar archive at: mozilla-central-354cb3932e36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630482 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:26.775894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:26.776269) ========= script_repo_revision: 354cb3932e36994d7e772cedba237e9c3c60fe4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:26.776700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:26.777014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 16:06:26.789086) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-15 16:06:26.789808) ========= /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=20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:06:27 INFO - MultiFileLogger online at 20160415 16:06:27 in /builds/slave/test 16:06:27 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 16:06:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:06:27 INFO - {'append_to_log': False, 16:06:27 INFO - 'base_work_dir': '/builds/slave/test', 16:06:27 INFO - 'blob_upload_branch': 'Firefox', 16:06:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:06:27 INFO - 'branch': 'Firefox', 16:06:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:06:27 INFO - 'config_files': ('talos/linux_config.py',), 16:06:27 INFO - 'default_actions': ('clobber', 16:06:27 INFO - 'read-buildbot-config', 16:06:27 INFO - 'download-and-extract', 16:06:27 INFO - 'populate-webroot', 16:06:27 INFO - 'create-virtualenv', 16:06:27 INFO - 'install', 16:06:27 INFO - 'run-tests'), 16:06:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:06:27 INFO - 'download_minidump_stackwalk': True, 16:06:27 INFO - 'download_symbols': 'ondemand', 16:06:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:06:27 INFO - 'tooltool.py': '/tools/tooltool.py', 16:06:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:06:27 INFO - '/tools/misc-python/virtualenv.py')}, 16:06:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:06:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:06:27 INFO - 'installer_path': 'installer.exe', 16:06:27 INFO - 'log_level': 'info', 16:06:27 INFO - 'log_name': 'talos', 16:06:27 INFO - 'log_to_console': True, 16:06:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:06:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:06:27 INFO - 'opt_config_files': (), 16:06:27 INFO - 'pip_index': False, 16:06:27 INFO - 'sps_profile': False, 16:06:27 INFO - 'sps_profile_interval': 0, 16:06:27 INFO - 'suite': 'dromaeojs', 16:06:27 INFO - 'system_bits': '32', 16:06:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:06:27 INFO - 'title': 'talos-linux64-ix-015', 16:06:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:06:27 INFO - 'use_talos_json': True, 16:06:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:06:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:06:27 INFO - 'work_dir': 'build'} 16:06:27 INFO - ##### 16:06:27 INFO - ##### Running clobber step. 16:06:27 INFO - ##### 16:06:27 INFO - Running pre-action listener: _resource_record_pre_action 16:06:27 INFO - Running main action method: clobber 16:06:27 INFO - rmtree: /builds/slave/test/build 16:06:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:06:27 INFO - Running post-action listener: _resource_record_post_action 16:06:27 INFO - ##### 16:06:27 INFO - ##### Running read-buildbot-config step. 16:06:27 INFO - ##### 16:06:27 INFO - Running pre-action listener: _resource_record_pre_action 16:06:27 INFO - Running main action method: read_buildbot_config 16:06:27 INFO - Using buildbot properties: 16:06:27 INFO - { 16:06:27 INFO - "project": "", 16:06:27 INFO - "product": "firefox", 16:06:27 INFO - "script_repo_revision": "production", 16:06:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:06:27 INFO - "repository": "", 16:06:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:06:27 INFO - "buildid": "20160415133014", 16:06:27 INFO - "pgo_build": "True", 16:06:27 INFO - "basedir": "/builds/slave/test", 16:06:27 INFO - "buildnumber": 404, 16:06:27 INFO - "slavename": "talos-linux64-ix-015", 16:06:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:06:27 INFO - "platform": "ubuntu64_hw", 16:06:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:06:27 INFO - "branch": "mozilla-central", 16:06:27 INFO - "repo_path": "mozilla-central", 16:06:27 INFO - "revision": "354cb3932e36994d7e772cedba237e9c3c60fe4c", 16:06:27 INFO - "stage_platform": "linux64-pgo", 16:06:27 INFO - "builduid": "da4416bdeeee4531b060b39c4ce96a56", 16:06:27 INFO - "slavebuilddir": "test" 16:06:27 INFO - } 16:06:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:06:27 INFO - Running post-action listener: _resource_record_post_action 16:06:27 INFO - ##### 16:06:27 INFO - ##### Running download-and-extract step. 16:06:27 INFO - ##### 16:06:27 INFO - Running pre-action listener: _resource_record_pre_action 16:06:27 INFO - Running main action method: download_and_extract 16:06:27 INFO - mkdir: /builds/slave/test/build/tests 16:06: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')]} 16:06:27 INFO - https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:34 INFO - Downloaded 1361 bytes. 16:06:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:06:34 INFO - Using the following test package requirements: 16:06:34 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:06:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:06:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:06:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:34 INFO - u'jsshell-linux-x86_64.zip'], 16:06:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:06:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:06:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:06:34 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:06:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:06:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:06:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:06: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')]} 16:06:34 INFO - https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:06:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:06:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:06:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:38 INFO - Downloaded 23773498 bytes. 16:06:38 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'] 16:06:38 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 16:06:39 INFO - Return code: 0 16:06:39 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 16:06: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')]} 16:06:39 INFO - https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:50 INFO - Downloaded 23773498 bytes. 16:06:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:06:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:06:51 INFO - Return code: 0 16:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:51 INFO - https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:52 INFO - Downloaded 10841076 bytes. 16:06:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:06:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:06:53 INFO - Return code: 0 16:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:53 INFO - https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:06:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:06:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:06:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFDbskMuTk2U5isq6_KlJA/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 16:06:54 INFO - Downloaded 58243420 bytes. 16:06:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:06:54 INFO - mkdir: /builds/slave/test/properties 16:06:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:06:54 INFO - Writing to file /builds/slave/test/properties/build_url 16:06:54 INFO - Contents: 16:06:54 INFO - build_url:https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:06:55 INFO - Running post-action listener: _resource_record_post_action 16:06:55 INFO - Running post-action listener: set_extra_try_arguments 16:06:55 INFO - ##### 16:06:55 INFO - ##### Running populate-webroot step. 16:06:55 INFO - ##### 16:06:55 INFO - Running pre-action listener: _resource_record_pre_action 16:06:55 INFO - Running main action method: populate_webroot 16:06:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:06:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:06:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:06:55 INFO - '--tppagecycles', 16:06:55 INFO - '7'], 16:06:55 INFO - 'tests': ['tsvgm']}}, 16:06:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:06:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:06:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:06:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:06:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:55 INFO - 'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:55 INFO - 'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['damp', 'tps']}, 16:06:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:55 INFO - 'tests': ['damp', 'tps']}, 16:06:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['dromaeo_dom']}, 16:06:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:06:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['a11yr', 16:06:55 INFO - 'ts_paint', 16:06:55 INFO - 'tpaint', 16:06:55 INFO - 'sessionrestore', 16:06:55 INFO - 'sessionrestore_no_auto_restore', 16:06:55 INFO - 'tabpaint']}, 16:06:55 INFO - 'other-e10s': {'tests': ['a11yr', 16:06:55 INFO - 'ts_paint', 16:06:55 INFO - 'tpaint', 16:06:55 INFO - 'sessionrestore', 16:06:55 INFO - 'sessionrestore_no_auto_restore', 16:06:55 INFO - 'tabpaint']}, 16:06:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:06:55 INFO - 'ts_paint', 16:06:55 INFO - 'tpaint', 16:06:55 INFO - 'sessionrestore', 16:06:55 INFO - 'sessionrestore_no_auto_restore', 16:06:55 INFO - 'tabpaint']}, 16:06:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:06:55 INFO - 'ts_paint', 16:06:55 INFO - 'tpaint', 16:06:55 INFO - 'sessionrestore', 16:06:55 INFO - 'sessionrestore_no_auto_restore', 16:06:55 INFO - 'tabpaint']}, 16:06:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['a11yr', 16:06:55 INFO - 'ts_paint', 16:06:55 INFO - 'tpaint', 16:06:55 INFO - 'sessionrestore', 16:06:55 INFO - 'sessionrestore_no_auto_restore', 16:06:55 INFO - 'tabpaint']}, 16:06:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['a11yr', 16:06:55 INFO - 'ts_paint', 16:06:55 INFO - 'tpaint', 16:06:55 INFO - 'sessionrestore', 16:06:55 INFO - 'sessionrestore_no_auto_restore', 16:06:55 INFO - 'tabpaint']}, 16:06:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['tsvgx', 16:06:55 INFO - 'tsvgr_opacity', 16:06:55 INFO - 'tart', 16:06:55 INFO - 'tscrollx', 16:06:55 INFO - 'cart']}, 16:06:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:06:55 INFO - 'tsvgr_opacity', 16:06:55 INFO - 'tart', 16:06:55 INFO - 'tscrollx', 16:06:55 INFO - 'cart']}, 16:06:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:55 INFO - 'talos_options': ['--disable-e10s'], 16:06:55 INFO - 'tests': ['tp5o']}, 16:06:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:55 INFO - 'tests': ['tp5o']}, 16:06:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:55 INFO - 'talos_options': ['--disable-e10s', 16:06:55 INFO - '--xperf_path', 16:06:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:55 INFO - 'tests': ['tp5n']}, 16:06:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:55 INFO - 'talos_options': ['--xperf_path', 16:06:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:55 INFO - 'tests': ['tp5n']}}, 16:06:55 INFO - 'talos.zip': {'path': '', 16:06:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:06:55 INFO - Running post-action listener: _resource_record_post_action 16:06:55 INFO - ##### 16:06:55 INFO - ##### Running create-virtualenv step. 16:06:55 INFO - ##### 16:06:55 INFO - Running pre-action listener: _resource_record_pre_action 16:06:55 INFO - Running main action method: create_virtualenv 16:06:55 INFO - Creating virtualenv /builds/slave/test/build/venv 16:06:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:06:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:06:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:06:55 INFO - Using real prefix '/usr' 16:06:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:06:56 INFO - Installing distribute.............................................................................................................................................................................................done. 16:06:58 INFO - Installing pip.................done. 16:06:58 INFO - Return code: 0 16:06:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f094fb22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12629a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', '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 16:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:06:58 INFO - Using env: {'DISPLAY': ':0', 16:06:58 INFO - 'HOME': '/home/cltbld', 16:06:58 INFO - 'LANG': 'en_US.UTF-8', 16:06:58 INFO - 'LANGUAGE': 'en_US:en', 16:06:58 INFO - 'LOGNAME': 'cltbld', 16:06:58 INFO - 'MAIL': '/var/mail/cltbld', 16:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:58 INFO - 'MOZ_NO_REMOTE': '1', 16:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:58 INFO - 'NO_EM_RESTART': '1', 16:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:58 INFO - 'PWD': '/builds/slave/test', 16:06:58 INFO - 'SHELL': '/bin/bash', 16:06:58 INFO - 'SHLVL': '1', 16:06:58 INFO - 'TERM': 'linux', 16:06:58 INFO - 'TMOUT': '86400', 16:06:58 INFO - 'USER': 'cltbld', 16:06:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:58 INFO - '_': '/tools/buildbot/bin/python'} 16:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:06:58 INFO - Cleaning up... 16:06:58 INFO - Return code: 0 16:06:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f094fb22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12629a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', '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 16:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:06:58 INFO - Using env: {'DISPLAY': ':0', 16:06:58 INFO - 'HOME': '/home/cltbld', 16:06:58 INFO - 'LANG': 'en_US.UTF-8', 16:06:58 INFO - 'LANGUAGE': 'en_US:en', 16:06:58 INFO - 'LOGNAME': 'cltbld', 16:06:58 INFO - 'MAIL': '/var/mail/cltbld', 16:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:58 INFO - 'MOZ_NO_REMOTE': '1', 16:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:58 INFO - 'NO_EM_RESTART': '1', 16:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:58 INFO - 'PWD': '/builds/slave/test', 16:06:58 INFO - 'SHELL': '/bin/bash', 16:06:58 INFO - 'SHLVL': '1', 16:06:58 INFO - 'TERM': 'linux', 16:06:58 INFO - 'TMOUT': '86400', 16:06:58 INFO - 'USER': 'cltbld', 16:06:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:58 INFO - '_': '/tools/buildbot/bin/python'} 16:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:58 INFO - Downloading/unpacking psutil>=0.7.1 16:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:07:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:00 INFO - Installing collected packages: psutil 16:07:00 INFO - Running setup.py install for psutil 16:07:00 INFO - building 'psutil._psutil_linux' extension 16:07:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:07:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:07:00 INFO - building 'psutil._psutil_posix' extension 16:07:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:07:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:07:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:01 INFO - Successfully installed psutil 16:07:01 INFO - Cleaning up... 16:07:01 INFO - Return code: 0 16:07:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f094fb22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12629a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', '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 16:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:07:01 INFO - Using env: {'DISPLAY': ':0', 16:07:01 INFO - 'HOME': '/home/cltbld', 16:07:01 INFO - 'LANG': 'en_US.UTF-8', 16:07:01 INFO - 'LANGUAGE': 'en_US:en', 16:07:01 INFO - 'LOGNAME': 'cltbld', 16:07:01 INFO - 'MAIL': '/var/mail/cltbld', 16:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:01 INFO - 'MOZ_NO_REMOTE': '1', 16:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:01 INFO - 'NO_EM_RESTART': '1', 16:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:01 INFO - 'PWD': '/builds/slave/test', 16:07:01 INFO - 'SHELL': '/bin/bash', 16:07:01 INFO - 'SHLVL': '1', 16:07:01 INFO - 'TERM': 'linux', 16:07:01 INFO - 'TMOUT': '86400', 16:07:01 INFO - 'USER': 'cltbld', 16:07:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:01 INFO - '_': '/tools/buildbot/bin/python'} 16:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:07:03 INFO - Installing collected packages: mozsystemmonitor 16:07:03 INFO - Running setup.py install for mozsystemmonitor 16:07:03 INFO - Successfully installed mozsystemmonitor 16:07:03 INFO - Cleaning up... 16:07:03 INFO - Return code: 0 16:07:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f094fb22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12629a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', '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 16:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:07:03 INFO - Using env: {'DISPLAY': ':0', 16:07:03 INFO - 'HOME': '/home/cltbld', 16:07:03 INFO - 'LANG': 'en_US.UTF-8', 16:07:03 INFO - 'LANGUAGE': 'en_US:en', 16:07:03 INFO - 'LOGNAME': 'cltbld', 16:07:03 INFO - 'MAIL': '/var/mail/cltbld', 16:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:03 INFO - 'MOZ_NO_REMOTE': '1', 16:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:03 INFO - 'NO_EM_RESTART': '1', 16:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:03 INFO - 'PWD': '/builds/slave/test', 16:07:03 INFO - 'SHELL': '/bin/bash', 16:07:03 INFO - 'SHLVL': '1', 16:07:03 INFO - 'TERM': 'linux', 16:07:03 INFO - 'TMOUT': '86400', 16:07:03 INFO - 'USER': 'cltbld', 16:07:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:03 INFO - '_': '/tools/buildbot/bin/python'} 16:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:03 INFO - Downloading/unpacking blobuploader==1.2.4 16:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:05 INFO - Downloading blobuploader-1.2.4.tar.gz 16:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:07:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:07:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:06 INFO - Downloading docopt-0.6.1.tar.gz 16:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:07:06 INFO - Installing collected packages: blobuploader, requests, docopt 16:07:06 INFO - Running setup.py install for blobuploader 16:07:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:07:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:07:06 INFO - Running setup.py install for requests 16:07:06 INFO - Running setup.py install for docopt 16:07:06 INFO - Successfully installed blobuploader requests docopt 16:07:06 INFO - Cleaning up... 16:07:06 INFO - Return code: 0 16:07:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f094fb22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12629a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', '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 16:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:07:07 INFO - Using env: {'DISPLAY': ':0', 16:07:07 INFO - 'HOME': '/home/cltbld', 16:07:07 INFO - 'LANG': 'en_US.UTF-8', 16:07:07 INFO - 'LANGUAGE': 'en_US:en', 16:07:07 INFO - 'LOGNAME': 'cltbld', 16:07:07 INFO - 'MAIL': '/var/mail/cltbld', 16:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:07 INFO - 'MOZ_NO_REMOTE': '1', 16:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:07 INFO - 'NO_EM_RESTART': '1', 16:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:07 INFO - 'PWD': '/builds/slave/test', 16:07:07 INFO - 'SHELL': '/bin/bash', 16:07:07 INFO - 'SHLVL': '1', 16:07:07 INFO - 'TERM': 'linux', 16:07:07 INFO - 'TMOUT': '86400', 16:07:07 INFO - 'USER': 'cltbld', 16:07:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:07 INFO - '_': '/tools/buildbot/bin/python'} 16:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:07 INFO - Running setup.py (path:/tmp/pip-9C8zM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:07 INFO - Running setup.py (path:/tmp/pip-zXbIOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:07 INFO - Running setup.py (path:/tmp/pip-2VuEK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:07 INFO - Running setup.py (path:/tmp/pip-bd4HVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:07 INFO - Running setup.py (path:/tmp/pip-uvYHzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:07 INFO - Running setup.py (path:/tmp/pip-c3ksdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:07 INFO - Running setup.py (path:/tmp/pip-6Jm1uF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:07 INFO - Running setup.py (path:/tmp/pip-i9zi73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:07 INFO - Running setup.py (path:/tmp/pip-gAS5UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:07 INFO - Running setup.py (path:/tmp/pip-Zbkv9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:07 INFO - Running setup.py (path:/tmp/pip-fLD87n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:08 INFO - Running setup.py (path:/tmp/pip-_lSqAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:08 INFO - Running setup.py (path:/tmp/pip-QzJtiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:08 INFO - Running setup.py (path:/tmp/pip-dyKPKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:08 INFO - Running setup.py (path:/tmp/pip-QAsT6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:08 INFO - Running setup.py (path:/tmp/pip-Ozwa0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:08 INFO - Running setup.py (path:/tmp/pip-TOq6av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:07:08 INFO - Running setup.py install for manifestparser 16:07:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:07:08 INFO - Running setup.py install for mozcrash 16:07:08 INFO - Running setup.py install for mozdebug 16:07:08 INFO - Running setup.py install for mozdevice 16:07:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:07:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:07:08 INFO - Running setup.py install for mozfile 16:07:08 INFO - Running setup.py install for mozhttpd 16:07:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Running setup.py install for mozinfo 16:07:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Running setup.py install for mozInstall 16:07:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Running setup.py install for mozleak 16:07:09 INFO - Running setup.py install for mozlog 16:07:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Running setup.py install for moznetwork 16:07:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Running setup.py install for mozprocess 16:07:09 INFO - Running setup.py install for mozprofile 16:07:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Running setup.py install for mozrunner 16:07:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:07:09 INFO - Running setup.py install for mozscreenshot 16:07:10 INFO - Running setup.py install for moztest 16:07:10 INFO - Running setup.py install for mozversion 16:07:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:07:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:07:10 INFO - Cleaning up... 16:07:10 INFO - Return code: 0 16:07:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f094fb22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12629a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', '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 16:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:07:10 INFO - Using env: {'DISPLAY': ':0', 16:07:10 INFO - 'HOME': '/home/cltbld', 16:07:10 INFO - 'LANG': 'en_US.UTF-8', 16:07:10 INFO - 'LANGUAGE': 'en_US:en', 16:07:10 INFO - 'LOGNAME': 'cltbld', 16:07:10 INFO - 'MAIL': '/var/mail/cltbld', 16:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:10 INFO - 'MOZ_NO_REMOTE': '1', 16:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:10 INFO - 'NO_EM_RESTART': '1', 16:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:10 INFO - 'PWD': '/builds/slave/test', 16:07:10 INFO - 'SHELL': '/bin/bash', 16:07:10 INFO - 'SHLVL': '1', 16:07:10 INFO - 'TERM': 'linux', 16:07:10 INFO - 'TMOUT': '86400', 16:07:10 INFO - 'USER': 'cltbld', 16:07:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:10 INFO - '_': '/tools/buildbot/bin/python'} 16:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:10 INFO - Running setup.py (path:/tmp/pip-5I4Prx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:10 INFO - Running setup.py (path:/tmp/pip-fDJ31J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:10 INFO - Running setup.py (path:/tmp/pip-sLSXYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:10 INFO - Running setup.py (path:/tmp/pip-vBm2k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:10 INFO - Running setup.py (path:/tmp/pip-KloB5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:10 INFO - Running setup.py (path:/tmp/pip-J7ZRjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:10 INFO - Running setup.py (path:/tmp/pip-oGVGPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:10 INFO - Running setup.py (path:/tmp/pip-zVTwQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:11 INFO - Running setup.py (path:/tmp/pip-q9SFAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:11 INFO - Running setup.py (path:/tmp/pip-sHc9_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:11 INFO - Running setup.py (path:/tmp/pip-yF7V17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:11 INFO - Running setup.py (path:/tmp/pip-oOVqr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:11 INFO - Running setup.py (path:/tmp/pip-NLs3Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:11 INFO - Running setup.py (path:/tmp/pip-O8FjN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:11 INFO - Running setup.py (path:/tmp/pip-xyMP3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:11 INFO - Running setup.py (path:/tmp/pip-YBrvqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:11 INFO - Running setup.py (path:/tmp/pip-Lu8bEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:07:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:13 INFO - Downloading blessings-1.6.tar.gz 16:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:07:13 INFO - Installing collected packages: blessings 16:07:13 INFO - Running setup.py install for blessings 16:07:13 INFO - Successfully installed blessings 16:07:13 INFO - Cleaning up... 16:07:13 INFO - Return code: 0 16:07:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:07:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:13 INFO - Reading from file tmpfile_stdout 16:07:13 INFO - Current package versions: 16:07:13 INFO - argparse == 1.2.1 16:07:13 INFO - blessings == 1.6 16:07:13 INFO - blobuploader == 1.2.4 16:07:13 INFO - docopt == 0.6.1 16:07:14 INFO - manifestparser == 1.1 16:07:14 INFO - mozInstall == 1.12 16:07:14 INFO - mozcrash == 0.17 16:07:14 INFO - mozdebug == 0.1 16:07:14 INFO - mozdevice == 0.48 16:07:14 INFO - mozfile == 1.2 16:07:14 INFO - mozhttpd == 0.7 16:07:14 INFO - mozinfo == 0.9 16:07:14 INFO - mozleak == 0.1 16:07:14 INFO - mozlog == 3.1 16:07:14 INFO - moznetwork == 0.27 16:07:14 INFO - mozprocess == 0.22 16:07:14 INFO - mozprofile == 0.28 16:07:14 INFO - mozrunner == 6.11 16:07:14 INFO - mozscreenshot == 0.1 16:07:14 INFO - mozsystemmonitor == 0.0 16:07:14 INFO - moztest == 0.7 16:07:14 INFO - mozversion == 1.4 16:07:14 INFO - psutil == 3.1.1 16:07:14 INFO - requests == 1.2.3 16:07:14 INFO - wsgiref == 0.1.2 16:07:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f094fb22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12629a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', '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 16:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:07:14 INFO - Using env: {'DISPLAY': ':0', 16:07:14 INFO - 'HOME': '/home/cltbld', 16:07:14 INFO - 'LANG': 'en_US.UTF-8', 16:07:14 INFO - 'LANGUAGE': 'en_US:en', 16:07:14 INFO - 'LOGNAME': 'cltbld', 16:07:14 INFO - 'MAIL': '/var/mail/cltbld', 16:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:14 INFO - 'MOZ_NO_REMOTE': '1', 16:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:14 INFO - 'NO_EM_RESTART': '1', 16:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:14 INFO - 'PWD': '/builds/slave/test', 16:07:14 INFO - 'SHELL': '/bin/bash', 16:07:14 INFO - 'SHLVL': '1', 16:07:14 INFO - 'TERM': 'linux', 16:07:14 INFO - 'TMOUT': '86400', 16:07:14 INFO - 'USER': 'cltbld', 16:07:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:14 INFO - '_': '/tools/buildbot/bin/python'} 16:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:07:14 INFO - Cleaning up... 16:07:14 INFO - Return code: 0 16:07:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f094fb22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12629a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', '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 16:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:07:14 INFO - Using env: {'DISPLAY': ':0', 16:07:14 INFO - 'HOME': '/home/cltbld', 16:07:14 INFO - 'LANG': 'en_US.UTF-8', 16:07:14 INFO - 'LANGUAGE': 'en_US:en', 16:07:14 INFO - 'LOGNAME': 'cltbld', 16:07:14 INFO - 'MAIL': '/var/mail/cltbld', 16:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:14 INFO - 'MOZ_NO_REMOTE': '1', 16:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:14 INFO - 'NO_EM_RESTART': '1', 16:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:14 INFO - 'PWD': '/builds/slave/test', 16:07:14 INFO - 'SHELL': '/bin/bash', 16:07:14 INFO - 'SHLVL': '1', 16:07:14 INFO - 'TERM': 'linux', 16:07:14 INFO - 'TMOUT': '86400', 16:07:14 INFO - 'USER': 'cltbld', 16:07:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:14 INFO - '_': '/tools/buildbot/bin/python'} 16:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:14 INFO - Downloading/unpacking jsonschema 16:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:07:16 INFO - Downloading/unpacking functools32 (from jsonschema) 16:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:16 INFO - Downloading functools32-3.2.3-2.tar.gz 16:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:07:16 INFO - warning: no files found matching '*.txt' 16:07:16 INFO - no previously-included directories found matching 'build' 16:07:16 INFO - no previously-included directories found matching 'dist' 16:07:16 INFO - no previously-included directories found matching '.git*' 16:07:16 INFO - Installing collected packages: jsonschema, functools32 16:07:16 INFO - Running setup.py install for functools32 16:07:16 INFO - warning: no files found matching '*.txt' 16:07:16 INFO - no previously-included directories found matching 'build' 16:07:16 INFO - no previously-included directories found matching 'dist' 16:07:16 INFO - no previously-included directories found matching '.git*' 16:07:16 INFO - Successfully installed jsonschema functools32 16:07:16 INFO - Cleaning up... 16:07:16 INFO - Return code: 0 16:07:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:16 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 0x7f094fb22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12629a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', '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 16:07:16 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 16:07:16 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 16:07:16 INFO - Using env: {'DISPLAY': ':0', 16:07:16 INFO - 'HOME': '/home/cltbld', 16:07:16 INFO - 'LANG': 'en_US.UTF-8', 16:07:16 INFO - 'LANGUAGE': 'en_US:en', 16:07:16 INFO - 'LOGNAME': 'cltbld', 16:07:16 INFO - 'MAIL': '/var/mail/cltbld', 16:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:16 INFO - 'MOZ_NO_REMOTE': '1', 16:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:16 INFO - 'NO_EM_RESTART': '1', 16:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:16 INFO - 'PWD': '/builds/slave/test', 16:07:16 INFO - 'SHELL': '/bin/bash', 16:07:16 INFO - 'SHLVL': '1', 16:07:16 INFO - 'TERM': 'linux', 16:07:16 INFO - 'TMOUT': '86400', 16:07:16 INFO - 'USER': 'cltbld', 16:07:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:16 INFO - '_': '/tools/buildbot/bin/python'} 16:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:16 INFO - Downloading/unpacking flake8 16:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:07:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:07:18 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 16:07:18 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 16:07:18 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 16:07:18 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 16:07:18 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 16:07:18 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 16:07:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:07:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:07:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:19 INFO - no previously-included directories found matching 'docs/_build' 16:07:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:07:19 INFO - Running setup.py install for pep8 16:07:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:19 INFO - no previously-included directories found matching 'docs/_build' 16:07:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:07:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:07:19 INFO - Cleaning up... 16:07:19 INFO - Return code: 0 16:07:19 INFO - Running post-action listener: _resource_record_post_action 16:07:19 INFO - Running post-action listener: _start_resource_monitoring 16:07:19 INFO - Starting resource monitoring. 16:07:19 INFO - ##### 16:07:19 INFO - ##### Running install step. 16:07:19 INFO - ##### 16:07:19 INFO - Running pre-action listener: _resource_record_pre_action 16:07:19 INFO - Running main action method: install 16:07:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:20 INFO - Reading from file tmpfile_stdout 16:07:20 INFO - Detecting whether we're running mozinstall >=1.0... 16:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:07:20 INFO - Reading from file tmpfile_stdout 16:07:20 INFO - Output received: 16:07:20 INFO - Usage: mozinstall [options] installer 16:07:20 INFO - Options: 16:07:20 INFO - -h, --help show this help message and exit 16:07:20 INFO - -d DEST, --destination=DEST 16:07:20 INFO - Directory to install application into. [default: 16:07:20 INFO - "/builds/slave/test"] 16:07:20 INFO - --app=APP Application being installed. [default: firefox] 16:07:20 INFO - mkdir: /builds/slave/test/build/application 16:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:07:36 INFO - Reading from file tmpfile_stdout 16:07:36 INFO - Output received: 16:07:36 INFO - /builds/slave/test/build/application/firefox/firefox 16:07:36 INFO - Running post-action listener: _resource_record_post_action 16:07:36 INFO - ##### 16:07:36 INFO - ##### Running run-tests step. 16:07:36 INFO - ##### 16:07:36 INFO - Running pre-action listener: _resource_record_pre_action 16:07:36 INFO - Running main action method: run_tests 16:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:07:36 INFO - Python 2.7.3 16:07:36 INFO - Return code: 0 16:07:36 INFO - grabbing minidump binary from tooltool 16:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1810>, '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 0x12f2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f2ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:07:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:07:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:07:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:07:36 INFO - Return code: 0 16:07:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:07:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:07:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:07:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:07:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:07:37 INFO - Return code: 0 16:07:37 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/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 16:07:37 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/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 16:07:37 INFO - Using env: {'DISPLAY': ':0', 16:07:37 INFO - 'HOME': '/home/cltbld', 16:07:37 INFO - 'LANG': 'en_US.UTF-8', 16:07:37 INFO - 'LANGUAGE': 'en_US:en', 16:07:37 INFO - 'LOGNAME': 'cltbld', 16:07:37 INFO - 'MAIL': '/var/mail/cltbld', 16:07:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:37 INFO - 'MOZ_NO_REMOTE': '1', 16:07:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:37 INFO - 'NO_EM_RESTART': '1', 16:07:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:37 INFO - 'PWD': '/builds/slave/test', 16:07:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:37 INFO - 'SHELL': '/bin/bash', 16:07:37 INFO - 'SHLVL': '1', 16:07:37 INFO - 'TERM': 'linux', 16:07:37 INFO - 'TMOUT': '86400', 16:07:37 INFO - 'USER': 'cltbld', 16:07:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530', 16:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:37 INFO - '_': '/tools/buildbot/bin/python'} 16:07:37 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/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 16:07:37 INFO - mozversion application_buildid: 20160415133014 16:07:37 INFO - mozversion application_changeset: 354cb3932e36994d7e772cedba237e9c3c60fe4c 16:07:37 INFO - mozversion application_display_name: Nightly 16:07:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:07:37 INFO - mozversion application_name: Firefox 16:07:37 INFO - mozversion application_remotingname: firefox 16:07:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:07:37 INFO - mozversion application_vendor: Mozilla 16:07:37 INFO - mozversion application_version: 48.0a1 16:07:37 INFO - mozversion platform_buildid: 20160415133014 16:07:37 INFO - mozversion platform_changeset: 354cb3932e36994d7e772cedba237e9c3c60fe4c 16:07:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:07:37 INFO - mozversion platform_version: 48.0a1 16:07:37 INFO - using testdate: 1460761657 16:07:37 INFO - actual date: 1460761657 16:07:37 INFO - starting webserver on 'localhost:33977' 16:07:37 INFO - SUITE-START | Running 2 tests 16:07:37 INFO - TEST-START | dromaeo_css 16:07:37 INFO - operating with platform_type : linux_ 16:07:37 INFO - Initialising browser for dromaeo_css test... 16:07:37 INFO - TEST-INFO | started process 24487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqwQpwq/profile http://localhost:33977/getInfo.html) 16:07:41 INFO - PROCESS | 24487 | __metrics Screen width/height:1600/1200 16:07:41 INFO - PROCESS | 24487 | colorDepth:24 16:07:41 INFO - PROCESS | 24487 | Browser inner width/height: 1024/697 16:07:41 INFO - PROCESS | 24487 | __metrics 16:07:43 ERROR - PROCESS | 24487 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:07:44 INFO - TEST-INFO | 24487: exit 0 16:07:44 INFO - Browser initialized. 16:07:44 INFO - Running cycle 1/1 for dromaeo_css test... 16:07:44 INFO - TEST-INFO | started process 24570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqwQpwq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:56 INFO - PROCESS | 24570 | RSS: Main: 152772608 16:07:56 INFO - PROCESS | 24570 | 16:08:47 INFO - PROCESS | 24570 | 1460761727127 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] 16:10:54 INFO - PROCESS | 24570 | Cycle 1(1): loaded http://localhost:33977/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33977/tests/dromaeo/cssquery-ext.html) 16:10:55 INFO - PROCESS | 24570 | RSS: Main: 256253952 16:10:55 INFO - PROCESS | 24570 | 16:13:57 INFO - PROCESS | 24570 | Cycle 1(1): loaded http://localhost:33977/tests/dromaeo/cssquery-ext.html (next: http://localhost:33977/tests/dromaeo/cssquery-jquery.html) 16:13:58 INFO - PROCESS | 24570 | RSS: Main: 241762304 16:13:58 INFO - PROCESS | 24570 | 16:17:00 INFO - PROCESS | 24570 | Cycle 1(1): loaded http://localhost:33977/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33977/tests/dromaeo/cssquery-mootools.html) 16:17:00 INFO - PROCESS | 24570 | RSS: Main: 242434048 16:17:00 INFO - PROCESS | 24570 | 16:20:02 INFO - PROCESS | 24570 | Cycle 1(1): loaded http://localhost:33977/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33977/tests/dromaeo/cssquery-prototype.html) 16:20:03 INFO - PROCESS | 24570 | RSS: Main: 231895040 16:20:03 INFO - PROCESS | 24570 | 16:23:05 INFO - PROCESS | 24570 | Cycle 1(1): loaded http://localhost:33977/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33977/tests/dromaeo/cssquery-yui.html) 16:23:06 INFO - PROCESS | 24570 | RSS: Main: 220827648 16:23:06 INFO - PROCESS | 24570 | 16:26:08 INFO - PROCESS | 24570 | Cycle 1(1): loaded http://localhost:33977/tests/dromaeo/cssquery-yui.html (next: http://localhost:33977/tests/dromaeo/cssquery-dojo.html) 16:26:09 INFO - PROCESS | 24570 | RSS: Main: 261529600 16:26:09 INFO - PROCESS | 24570 | 16:26:09 INFO - PROCESS | 24570 | __start_tp_report 16:26:09 INFO - PROCESS | 24570 | _x_x_mozilla_page_load 16:26:09 INFO - PROCESS | 24570 | _x_x_mozilla_page_load_details 16:26:09 INFO - PROCESS | 24570 | |i|pagename|runs| 16:26:09 INFO - PROCESS | 24570 | |0;dojo.html;3027.6064111665487;3088.305131345446;3123.6407813101487;3123.984380078101;3152.196189971556;5179.870503237421;5223.686578805275;5228.137357336035;5251.8949621007605;5265.078611243036;5212.791488340471;5217.713025783581;5230.581553475722;5242.292290540776;5263.894722105565;4689.062187562484;4723.527647235274;4829.589484893788;4871.147549178897;4889.462159162489;4808.567228949394;4829.613630909536;4851;4865.41615006198;4878.438979517347;4676.789544470507;4677.8830529236875;4750.61995040396;4794.760261986921;4795.6163506919365;4735.526447355272;4778.832740854054;4783.736894470802;4785.976070119627;4816.181249187612;4589.885252868671;4699.624030077585;4743.739094349809;4756.808418495594;4823.734694591796;5038.294638750578;5077.974610126963;5100.744962751847;5102.770375333119;5165.845024649267;5448.45515448456;5483.917741233885;5493.697846618435;5493.697846618435;5541.27963364764;5491.780328786844;5539.750711218005;5567.47109024642;5620.297462817148;5707.600467967244;5166.7674954626755;5185.222216667492;5190.09173394662;5241.868953276123;5249.947500525022;5635.492805647511;5643.830685079454;5645.887082258414;5647.830565083054;5654.85862853432;5390.137577987503;5410.1343784995;5502.862428439321;5567.66594004361;5577.860553486195;5586.078297080936;5609.411011843779;5614.466625670555;5622.184783206494;5624.072028115397;5573.777048918079;5579.497845193952;5581.972090139605;5583.246261754693;5585.022621041301;5357.491038351351;5596.552275817925;5658.886822263532;5703.344115426696;5713.914291285634;4283.31466965284;4285.657147428198;4289.806958686867;4292.163028209532;4324.027093903909;3780.8487660493824;3842.9231415371537;3850.172212974224;3864.594217607167;3899.922001559953;5302.549283310885;5314.5748340132695;5317.202419637086;5343.038253114477;5366.302380690485;5604.579656525777;5658.122990936411;5662.68855212959;5663.065594176915;5664.376918538957;5214.97392513035;5294.655847369909;5322.042032434121;5323.52088312046;5403.243545903577;4736.7631618418945;4738.8341408050555;4760.904781904343;4800.3279540864305;4806.711597304173;5551.583631227593;5624.0439125348785;5628.296462942132;5646.096624540136;5674;5445.264889239902;5472.945270547403;5511.751971161227;5537.612367134342;5571.860703482445;5662.688552129673;5682.715864206691;5684.545236380997;5692.089265717631;5698.401667824819;5463.180522921593;5464.3442786865835;5464.781408743605;5466.644668096561;5467.72661366938;5488.56091512686;5601.551875849841;5642.069058605448;5718.142278658234;5730.770769169187;5378.569714422759;5389.622726409114;5392.6225164239695;5396.433374495621;5399.05516534597;5371.248025276543;5378.435264297193;5382.407935127055;5387.703676297841;5427.267318911896;5320.893582128413;5408.5673146149;5454.481824226692;5495.258140151029;5504.422035686195;5378.247045413567;5384.811531596375;5389.83830485086;5393.6224464287125;5402.837914862561;5236.390470587172;5245;5260.132078207206;5280.603954703336;5294.179402192666 16:26:09 INFO - PROCESS | 24570 | |1;ext.html;604.1391017799638;654.2214764430324;659.7130248341972;660.009985022466;666.5700623098102;31025;31767.841160794193;37566.24867502648;38889.41665875007;39032.80483597578;42946.785266073704;42987.78506107473;43297.78351108248;43361;43584.78207608966;8644.740657780276;8841.823163536757;8843.690470833522;8844.73465796024;8845.557722113901;8670.393072484929;8769.912300876973;8791.076936921627;8791.428557143798;8793.472391656522;8798.032216456184;8881.245094167003;8883.73348799537;8887.15572020657;8888.866667;8592.011918629343;8610.698625548108;8613.353998450079;8616.310695144437;8617.310615150804;8668.39321247513;8712.956435217846;8755.343349248767;8775.736727898173;8782.38523303369;39574.802125989474;40157;40163.59836401628;40189.39715904264;40193.59806401957;3371.5448414463976;3400.931981360359;3619.6561326673923;3803.82882770276;3905.1994341159993;31142;32070.35859282801;32377.190570235696;32381.35237295241;32403.6759632403;4178.39413285075;4235.724677895927;4307.332363483665;4312.89176348466;4317.330813723878;256668;276165;276348.99999999796;276402;276726;53605.1959220612;53768;53852.46147538474;54072;54160.729196353765;57218.42781572131;57252;57473;57817.132743008886;57846.710766445896;14665.413383464542;14673.192974386511;14775.40898364075;14811.259437028106;14812.70374592502;11107.500162492708;11109.333439993465;11122.61070862516;11124;11135.554577816958;15486.303116359792;15593.532194034196;15603.375864965501;15649.84350156484;15664.765028524582;6403.647799370986;6480.740770369132;6521.510886683518;6555.901661475082;6650.401463868178;964.7636329099415;1029.1149611334247;1033.338663255517;1078.9298695584762;1104.9502772375263;30208.852805649338;30886.536701949488;31802;32061.839690801397;32368.83815580907;1023.81059503992;1035.4615599888016;1037.1858091398217;1067.151614466501;1090.8527348807968;16174.75737863933;16652.83347166513;16844.831551684572;16998;17029.914850425917;372060;375511;376041;376191;377187;53778.46221537813;54942.450575493735;55040.72479637656;55062.17406738902;55212;1160.7794519041356;1279.8656141105237;1328.4022190014339;1399.6500874781304;1410.4076287959083;27755.86122069377;31158.532622011142;31823.204419888763;31949;32275.838620806746;43663.345049824915;43788.34317485177;44282;44295.335569965835;44355.556444436435;260795;260801;260968;261148;261315;34259;39156.412653809646;40474;40659.3901091478;40988.38517422182;39434.605653943094;40343.596564033985;40773;40828.59171408367;41575.37636935388;37730;37859.81070094632;38286.6171338283;38338.2332353357;38530.422043668805;36298.8185059073;37358.25283494369;38041.23917521689;39160;39254.41118383284;39558.2088358237;39797.80101099476;40068.79965600153;40121.59878401179;40949.795251023555;30223.244418888826;30433.23916902095;31422;32318.83840580782;35017.649823502456;27067.046078578518;27093;27175.72824271732;27406.45187096207;27486 16:26:09 INFO - PROCESS | 24570 | |2;jquery.html;388.6405075305342;391.53798517749055;395.75463212808063;400.47937681014685;409.32665764816875;17903.820961790378;18340.541486462844;18447.44657660269;18456.723149152756;19434.61130777387;16989;17057;17905.7314140288;18058.63882722348;18100.90949545254;5122.948770512294;5606.495415412612;5847.298324201101;5860.677662728548;5895.823125306248;5740.483356497914;5774.2782152230975;5783.681897495636;5786.479216870481;5807.477327040566;5687.459691329338;5742.655440673552;5755.647422855625;5760.193572899798;5762.596618236725;5570.6657600543895;5712.11462223356;5735.340435849847;5751.626144300607;5760.049591817345;4917.5574198321965;5096.821611243588;5139.640225184238;5145.665531740462;5149.639525233235;19457.902710486356;21570.1371945122;23097.769022309898;23434.296971090895;23442.296731098093;2145.5279838435517;2193.8573992690585;2220.4670878989086;2421.285720712394;2982.806117602349;14068.507602233873;14135.575932722035;14275.78586321206;14350.425982960669;14601.634959126;1944.7957964413815;1954.5699946011855;2024.7772744998185;2026.7973202679761;2046.6213750456063;76660.61669691616;76840;77865;78752.60623696845;79226.60386698088;10301.845472317922;10418.895811041793;10421.218408619385;10539.94730026345;10642.594369801744;14823.110613363233;14886.702265954837;14891.553253402415;14899.255037248095;14916.254187290591;7357.52176108562;7465.962670186615;7561.09266887977;7681.462297639224;7694;7163.928360716431;7195.352418282379;7276.745313913988;7292.8906066409045;7293.598852063082;6443.548951573439;6499.2850786413455;6590;6591.274959754423;6635.668216589152;1871.1579789094963;1922.1542521290587;1937.1960636335764;1957.0312695215675;1971.4184315626924;954.2556805691572;1038.1487180511908;1061.9150467962545;1085.4898197846999;1114.2812885688686;18939.90530047341;19277.90361048186;19296.517587060156;19455.513612159528;19459.90270048669;1005.8390657494766;1011.2415688233824;1015.8984101589782;1030.860833787444;1030.891756365571;10115.645952391631;10599.516067750521;10713.78572428547;10897.346159230472;11287;462665;467147;468391;469251;481106;89917;91003.54498227598;91104;92186.53906730423;92228;1028.6091285311534;1032.2516175772655;1065.8294672852307;1066.5893630951985;1072.7210925159359;16929.238184281985;16990;17164.882481918507;17177.656446871242;17281.39515116965;37037;37528.437073443376;37540.24919501649;37553.43669845009;37686.55037422559;52782;54901.45098548963;55234;55459.722701386236;55568.72215638896;8014.599270036591;8066.395020373378;8072.838543228985;8300.70947516834;8356.289715374262;9099.272058235192;12660.683482913;13060.477580896657;13119;13180.604581862559;11557.537698492302;11699;11712.180147389601;11840.70398240051;12014.75970480603;11211.495482703462;11627.244229125079;11774.116941229271;11780.05759539252;11781;11376.317420954769;11838.230515016496;11936.220941784155;12077.818832717341;12294.262344259372;7919;8090.87863682057;8192.467489613156;8309.83380332378;8838.513881736566;8503;10975;11835.940820295844;11897.643070707893;11946.581869634521 16:26:09 INFO - PROCESS | 24570 | |3;mootools.html;1341.2421981580412;1432.641839540115;1488.2261224163433;1551.1623723189477;1719.3122750899647;7116.4306855451505;7965.402594805391;8130.186981301867;8166.346692264619;8169.795755106125;7844.372450203984;8010.879836802453;8022;8026.157253488373;8028.036635603736;1976.7529058867642;2286.599845027122;2312.2138472919246;2342.8008619267384;2350.059976009593;2285.6228722260807;2326.5579539887367;2337.532493501298;2349.119080344871;2353.2587235020915;2240.529488807352;2272.704548408713;2272.977270227293;2273.102124660758;2278.7835155660187;1971.1327016112937;2217.84475086744;2269.920552780645;2278.7835155660187;2284.5088306014122;2186.3222401055564;2188.5513469738667;2190.452386903274;2198.8131008864266;2267.784560466753;8109.75670729879;8245.79385515367;8248.381371397169;8256.339492840558;8259.091499935003;5013;5186.688798672092;5204.68771873685;5214.374275086976;5217.6608520446425;3206.5350524174096;3244.821534815584;3296.175956010997;3377.257003459235;3396.932061358759;1065.387402243713;1082.4804094034828;1083.783243351325;1108.944552772358;1115.297362661518;11643.476043578059;11661.883381166164;11672.649820505398;11689.941550292195;11692.473838677195;4427.158839820424;4433.246348120827;4600.700954437951;4627.768611569475;4634.397528321364;9844.114029737215;9846.409215447096;9853.704388868202;9858.753531161778;9866.112049915542;4318.676099292566;5216.400113986864;5218.034663587248;5226.8954620908125;5249.632525723163;4577.679562430664;4655.883602909955;4670.042641258534;4682.250839865674;4682.765861706969;3878.9418158727076;3911.6088391161225;3997.4809572362897;4024.2957482440456;4052.3111071117983;1238.7894058009979;1277.0677405493855;1291.9741605167844;1301.1607513153963;1306.0857399820163;738.8891666250106;865.4634126841398;899.9010108888017;902.5397047505688;905.2591007693667;5616.157576363578;5651.265335506358;5734.971325143348;5871.4715675589405;5892.7642894283745;946.7254496196164;965.6958058211641;1014.7970405918845;1042.3381152967768;1046.3617193511952;3814.809259537012;3831.6743076838225;3842.212346468967;3867.0525721197923;3899.9610003899597;10457.058864702061;10726;10781.514831832586;10796;10812.837807432894;10642.680719578426;10672.306300090624;10694.358338499715;10708.732281692864;10731.356118632906;7528.644843928036;7677.884831727529;7733.4973226740085;7893.092294386104;7930.881036784453;5506.540766696909;5529.474699903502;5563.638363506359;5572.247746554163;5687.658740475585;9559.569819358006;9644.855327169958;9755.21958243353;9876.604935802487;9881.160101391462;9570;9814.803703926023;9937.552810123418;9954.25343099256;9996.750081248027;6329.683515824282;6955.269696681978;7061.8940715888275;7536.171021187774;7778.611069446391;7948.0859701132795;7966.482178658601;8025.759227223192;8043.235892590194;8047.758567242992;7035.648217589202;7223.783286501413;7245.963770181326;7290.635468226461;7307.26927307265;6850.862982740417;6854.485913556603;6981.092457980633;7074.646267686698;7241.927580724126;6396.32838551964;6498.512611554058;6504.73981040772;6511.446527045254;6512.5766825156215;4883.267509873547;4930.359053323045;5049.84850454487;5079.238114282887;5188.0661480933795;5173.248910172261;5187.548692195796;5192.844214673566;5290.153575428067;5297.443768404416 16:26:09 INFO - PROCESS | 24570 | |4;prototype.html;300.4486766782953;307.6938446245985;309.38123752495005;317.46507135476725;317.934823361211;5554.527865131464;5589.161625756134;5599.160125981105;5613.663180209191;5668.829935101953;5228.73856307185;5348.491893270133;5386.8922621547545;5546.807436401173;5556.472135147164;4203.936940945889;4238.088810905662;4241.6818738594575;4279.893002674942;4280.208161490134;4247.766372849492;4256.34026725858;4276.273033584298;4276.786160691969;4276.978615106936;4039.4142849286836;4087.9780054986254;4122.752634841904;4195.349720793282;4211.241976444238;4170.35359519275;4173.269677806372;4181.18118618402;4190.601892820192;4219.43037689911;3683.079230192452;3706.684931780802;3706.759060661075;3712.3874560697454;3738.6633354153655;5182.455842136596;5232.659877107976;5298.496642818926;5311.601629877775;5330.946690533084;4839.927401088987;4848.2727590861305;4870.09903167915;4887.584555312803;4900.8774780630765;5706.400827913092;5744.597878148531;5749.31008279005;5756.309242890838;5767.711614419304;3970.463987361698;4091.97954010228;4101.835926562934;4103.179364127186;4119.938200926958;5934.5252379809945;5975.9103613445395;5979.611325263844;5981.461668449817;5981.940180598225;4173.812178451977;4180.435641188462;4196.979015104966;4210.031692710632;4232.217039847576;4078.2659121358442;4257.084726783756;4295.699301048959;4310.719803212781;4315.266404711144;4910.680805747615;4921.975390123098;4926.261060840902;4943.728094954812;4944.777485013183;5878.5297176225795;5910.468057874812;5930.43660852227;5939;5954.523638108941;1395.5045958684723;1432.3912337256625;1456.8543145685346;1500.9399624015136;1507.773833924898;957.6456711016968;1000.7298029531986;1015.4516561056946;1017.3793985668736;1026.810040142576;5514.751836167302;5564.4141419696;5578.665280083208;5600.551955843523;5616.634918730269;5955.434233747787;5958.702064896738;5974.312954010345;5989.520838332923;5990.490808281258;5444.6188766785945;5597.3003374578175;5620.1288800236025;5629.493345598834;5644.181593668895;3151.842407879597;3166.7649616649524;3169.793963392372;3184.076617780864;3191.4095892260007;5800.796972105956;5999.400059993965;6013.729382177812;6053.4551890330085;6065.575409721366;6013.045760127889;6022.638641681513;6031.788887388921;6045.425684559959;6052.66710330936;6043.939560604425;6051.667158306335;6053.545984051214;6070.696465176812;6089.147519347206;5769.22115514417;5855.882882342415;5925.52595792327;5954.374790647093;5955.255593050869;5789.507891829242;5814.796482123105;5849.912251316318;5877.559997800567;5889.734961926809;5838.072351498231;6047.969760151171;6053.606515576474;6075.665838378932;6080.3615620361;4231.449911511484;4234.280172370766;4235.597618226264;4243.257429949685;4244.617984381297;5751.482366587027;5932.673702946379;5944.227250457413;5947.286325640951;5966.552508561962;5738.139279108167;5898.616589921641;5921.822345329647;5947.881042379215;5955.6724380157775;5872.20897626211;5876.206712093813;5886.823395298148;5901.350851406428;5925.111233315038;5610.831675049755;5784.421557844182;5793.159991801081;5798.072308430631;5849.415058494116;5896.49879760208;5924.911126333022;5939.762409503572;5941.009761729869;5955.166276721349;5535.501804837584;5762.279715035621;5790.855228619318;5798.59409841307;5819.854503637443 16:26:09 INFO - PROCESS | 24570 | |5;yui.html;682.5256446769491;684.8561802021575;700.8493173967596;720.2977097330103;732.4177279063148;12368.814467782979;12464.252144871303;12620.558280460185;12636.684082897933;12659;10799.892001079987;11217.383043932581;11224.382658953755;11269.887301126986;11900.226485278472;656.3600489522725;769.4729110559285;784.5528049012065;785.9371250299962;793.2345286798225;777.2421888658541;777.3237283563279;778.0702061037063;784.827337985645;796.2197046894047;818.4639061414783;818.7461886815076;819.5205804604313;823.7734622978699;835.6239692138531;676.6921050921843;806.9677212911477;811.3914564076942;812.7317985064915;828.6436832162168;590.946814786667;591.0985746736219;591.131037375058;605.4278706622243;611.8378629663143;11968.82046769299;12009.279443233347;12014;12014.639560813102;12034.939825300817;11763.588274410355;12469.376531173495;12596.81104783429;12618.116731828775;12637.20757519495;10262.9486852566;10393.064624183784;10414.479276036167;10440.79118417635;10546.736331591695;3674.9081272968124;3689.6494832990825;3691.1141326081815;3847.3459511883048;3866.516685414323;55993;56797;57484.13773793438;57840.71079644617;57851.71074144644;9760.560774765152;9814.901850981541;9826.557804898797;10135.138513226311;10349.379037257788;17654.382096626556;17831.910840445973;17863.28546858111;17904.820951790574;18120;7298.781036568911;7539.132999705104;7557.168711441737;7621.69513219465;7647.808804779925;4241.745495270294;4365.170617582649;4366.257736184856;4403;4406.030673251944;3031.4088752693015;3126.609173853268;3127.702868227515;3128.2804954860508;3135.3885992231294;615.4583966109794;629.2134831460675;634.8857205702925;635.5138319185827;636.6339354870968;469.79329095198005;535.7749745106986;611.9082137679384;641.9967900160469;711.4095300900241;8229.753107406787;8615.6984505542;8686.73939781795;8789.428687135316;8945.37382383227;687.0621601513998;695.8399568099366;706.2901783707341;712.2877122877123;713.5575942915426;3862.1503269280715;3952.604739526082;3963.8018099095507;3999.7600143991453;4111.321631930758;53581.464185358425;53762.731186343815;53817.73091134519;54392.18411723827;55114.724426378416;49758.50241497611;51142.23286650703;51650;51822.48177518177;52151;45132.3230151548;46234;46272.7686361566;46376.5362346379;47149.05701885943;7682.785608752936;7698.615069246403;7718.691252349843;7761.883571746541;7766.611669416619;28661.28346791347;29250.268743281587;29977.550336745404;30938;31289.530657039708;37662.81168594139;39977.400338994354;41470.79264603658;41688;42065;10727.141828653845;10752.193585480964;10819.404932728776;10865.239433239598;11018.228723989243;11511;11715.882841171479;11721.472533736172;11732.88267117352;11812.763744724885;8998.82002359936;10858.185636077167;10919.342020423248;11538.07695384384;11538.82691759641;11014.44927753625;11184;11338.94330528375;11366;12132.514699412277;11350.772984540428;11352.489137988645;11408.315501069963;11476.540938362372;11986.041116710468;9742.610295588098;9872.160866326443;9915.355501892354;9999.150072243941;10076.143527799926;9838.9016109838;10176.745581360525;10250.53872575721;10295.12491438236;10328.070473657406 16:26:09 INFO - PROCESS | 24570 | __end_tp_report 16:26:09 INFO - PROCESS | 24570 | __start_cc_report 16:26:09 INFO - PROCESS | 24570 | _x_x_mozilla_cycle_collect,781 16:26:09 INFO - PROCESS | 24570 | __end_cc_report 16:26:09 INFO - PROCESS | 24570 | __startTimestamp1460762769153__endTimestamp 16:26:09 INFO - PROCESS | 24570 | 16:26:09 INFO - PROCESS | 24570 | ------- Summary: start ------- 16:26:09 INFO - PROCESS | 24570 | Number of tests: 6 16:26:09 INFO - PROCESS | 24570 | 16:26:09 INFO - PROCESS | 24570 | [#0] dojo.html Cycles:165 Average:5174.59 Median:5378.25 stddev:562.16 (10.5%) stddev-sans-first:538.06 16:26:09 INFO - PROCESS | 24570 | Values: 3027.6 3088.3 3123.6 3124.0 3152.2 5179.9 5223.7 5228.1 5251.9 5265.1 5212.8 5217.7 5230.6 5242.3 5263.9 4689.1 4723.5 4829.6 4871.1 4889.5 4808.6 4829.6 4851.0 4865.4 4878.4 4676.8 4677.9 4750.6 4794.8 4795.6 4735.5 4778.8 4783.7 4786.0 4816.2 4589.9 4699.6 4743.7 4756.8 4823.7 5038.3 5078.0 5100.7 5102.8 5165.8 5448.5 5483.9 5493.7 5493.7 5541.3 5491.8 5539.8 5567.5 5620.3 5707.6 5166.8 5185.2 5190.1 5241.9 5249.9 5635.5 5643.8 5645.9 5647.8 5654.9 5390.1 5410.1 5502.9 5567.7 5577.9 5586.1 5609.4 5614.5 5622.2 5624.1 5573.8 5579.5 5582.0 5583.2 5585.0 5357.5 5596.6 5658.9 5703.3 5713.9 4283.3 4285.7 4289.8 4292.2 4324.0 3780.8 3842.9 3850.2 3864.6 3899.9 5302.5 5314.6 5317.2 5343.0 5366.3 5604.6 5658.1 5662.7 5663.1 5664.4 5215.0 5294.7 5322.0 5323.5 5403.2 4736.8 4738.8 4760.9 4800.3 4806.7 5551.6 5624.0 5628.3 5646.1 5674.0 5445.3 5472.9 5511.8 5537.6 5571.9 5662.7 5682.7 5684.5 5692.1 5698.4 5463.2 5464.3 5464.8 5466.6 5467.7 5488.6 5601.6 5642.1 5718.1 5730.8 5378.6 5389.6 5392.6 5396.4 5399.1 5371.2 5378.4 5382.4 5387.7 5427.3 5320.9 5408.6 5454.5 5495.3 5504.4 5378.2 5384.8 5389.8 5393.6 5402.8 5236.4 5245.0 5260.1 5280.6 5294.2 16:26:09 INFO - PROCESS | 24570 | 16:26:09 INFO - PROCESS | 24570 | [#1] ext.html Cycles:180 Average:47450.09 Median:38961.11 stddev:80497.37 (206.6%) stddev-sans-first:80646.34 16:26:09 INFO - PROCESS | 24570 | Values: 604.1 654.2 659.7 660.0 666.6 31025.0 31767.8 37566.2 38889.4 39032.8 42946.8 42987.8 43297.8 43361.0 43584.8 8644.7 8841.8 8843.7 8844.7 8845.6 8670.4 8769.9 8791.1 8791.4 8793.5 8798.0 8881.2 8883.7 8887.2 8888.9 8592.0 8610.7 8613.4 8616.3 8617.3 8668.4 8713.0 8755.3 8775.7 8782.4 39574.8 40157.0 40163.6 40189.4 40193.6 3371.5 3400.9 3619.7 3803.8 3905.2 31142.0 32070.4 32377.2 32381.4 32403.7 4178.4 4235.7 4307.3 4312.9 4317.3 256668.0 276165.0 276349.0 276402.0 276726.0 53605.2 53768.0 53852.5 54072.0 54160.7 57218.4 57252.0 57473.0 57817.1 57846.7 14665.4 14673.2 14775.4 14811.3 14812.7 11107.5 11109.3 11122.6 11124.0 11135.6 15486.3 15593.5 15603.4 15649.8 15664.8 6403.6 6480.7 6521.5 6555.9 6650.4 964.8 1029.1 1033.3 1078.9 1105.0 30208.9 30886.5 31802.0 32061.8 32368.8 1023.8 1035.5 1037.2 1067.2 1090.9 16174.8 16652.8 16844.8 16998.0 17029.9 372060.0 375511.0 376041.0 376191.0 377187.0 53778.5 54942.5 55040.7 55062.2 55212.0 1160.8 1279.9 1328.4 1399.7 1410.4 27755.9 31158.5 31823.2 31949.0 32275.8 43663.3 43788.3 44282.0 44295.3 44355.6 260795.0 260801.0 260968.0 261148.0 261315.0 34259.0 39156.4 40474.0 40659.4 40988.4 39434.6 40343.6 40773.0 40828.6 41575.4 37730.0 37859.8 38286.6 38338.2 38530.4 36298.8 37358.3 38041.2 39160.0 39254.4 39558.2 39797.8 40068.8 40121.6 40949.8 30223.2 30433.2 31422.0 32318.8 35017.6 27067.0 27093.0 27175.7 27406.5 27486.0 16:26:09 INFO - PROCESS | 24570 | 16:26:09 INFO - PROCESS | 24570 | [#2] jquery.html Cycles:180 Average:28066.27 Median:2207.16 stddev:77447.34 (3508.9%) stddev-sans-first:77636.72 16:26:09 INFO - PROCESS | 24570 | Values: 388.6 391.5 395.8 400.5 409.3 17903.8 18340.5 18447.4 18456.7 19434.6 16989.0 17057.0 17905.7 18058.6 18100.9 5122.9 5606.5 5847.3 5860.7 5895.8 5740.5 5774.3 5783.7 5786.5 5807.5 5687.5 5742.7 5755.6 5760.2 5762.6 5570.7 5712.1 5735.3 5751.6 5760.0 4917.6 5096.8 5139.6 5145.7 5149.6 19457.9 21570.1 23097.8 23434.3 23442.3 2145.5 2193.9 2220.5 2421.3 2982.8 14068.5 14135.6 14275.8 14350.4 14601.6 1944.8 1954.6 2024.8 2026.8 2046.6 76660.6 76840.0 77865.0 78752.6 79226.6 10301.8 10418.9 10421.2 10539.9 10642.6 14823.1 14886.7 14891.6 14899.3 14916.3 7357.5 7466.0 7561.1 7681.5 7694.0 7163.9 7195.4 7276.7 7292.9 7293.6 6443.5 6499.3 6590.0 6591.3 6635.7 1871.2 1922.2 1937.2 1957.0 1971.4 954.3 1038.1 1061.9 1085.5 1114.3 18939.9 19277.9 19296.5 19455.5 19459.9 1005.8 1011.2 1015.9 1030.9 1030.9 10115.6 10599.5 10713.8 10897.3 11287.0 462665.0 467147.0 468391.0 469251.0 481106.0 89917.0 91003.5 91104.0 92186.5 92228.0 1028.6 1032.3 1065.8 1066.6 1072.7 16929.2 16990.0 17164.9 17177.7 17281.4 37037.0 37528.4 37540.2 37553.4 37686.6 52782.0 54901.5 55234.0 55459.7 55568.7 8014.6 8066.4 8072.8 8300.7 8356.3 9099.3 12660.7 13060.5 13119.0 13180.6 11557.5 11699.0 11712.2 11840.7 12014.8 11211.5 11627.2 11774.1 11780.1 11781.0 11376.3 11838.2 11936.2 12077.8 12294.3 7919.0 8090.9 8192.5 8309.8 8838.5 8503.0 10975.0 11835.9 11897.6 11946.6 16:26:09 INFO - PROCESS | 24570 | 16:26:09 INFO - PROCESS | 24570 | [#3] mootools.html Cycles:180 Average:5538.17 Median:5187.12 stddev:3119.22 (60.1%) stddev-sans-first:3112.03 16:26:09 INFO - PROCESS | 24570 | Values: 1341.2 1432.6 1488.2 1551.2 1719.3 7116.4 7965.4 8130.2 8166.3 8169.8 7844.4 8010.9 8022.0 8026.2 8028.0 1976.8 2286.6 2312.2 2342.8 2350.1 2285.6 2326.6 2337.5 2349.1 2353.3 2240.5 2272.7 2273.0 2273.1 2278.8 1971.1 2217.8 2269.9 2278.8 2284.5 2186.3 2188.6 2190.5 2198.8 2267.8 8109.8 8245.8 8248.4 8256.3 8259.1 5013.0 5186.7 5204.7 5214.4 5217.7 3206.5 3244.8 3296.2 3377.3 3396.9 1065.4 1082.5 1083.8 1108.9 1115.3 11643.5 11661.9 11672.6 11689.9 11692.5 4427.2 4433.2 4600.7 4627.8 4634.4 9844.1 9846.4 9853.7 9858.8 9866.1 4318.7 5216.4 5218.0 5226.9 5249.6 4577.7 4655.9 4670.0 4682.3 4682.8 3878.9 3911.6 3997.5 4024.3 4052.3 1238.8 1277.1 1292.0 1301.2 1306.1 738.9 865.5 899.9 902.5 905.3 5616.2 5651.3 5735.0 5871.5 5892.8 946.7 965.7 1014.8 1042.3 1046.4 3814.8 3831.7 3842.2 3867.1 3900.0 10457.1 10726.0 10781.5 10796.0 10812.8 10642.7 10672.3 10694.4 10708.7 10731.4 7528.6 7677.9 7733.5 7893.1 7930.9 5506.5 5529.5 5563.6 5572.2 5687.7 9559.6 9644.9 9755.2 9876.6 9881.2 9570.0 9814.8 9937.6 9954.3 9996.8 6329.7 6955.3 7061.9 7536.2 7778.6 7948.1 7966.5 8025.8 8043.2 8047.8 7035.6 7223.8 7246.0 7290.6 7307.3 6850.9 6854.5 6981.1 7074.6 7241.9 6396.3 6498.5 6504.7 6511.4 6512.6 4883.3 4930.4 5049.8 5079.2 5188.1 5173.2 5187.5 5192.8 5290.2 5297.4 16:26:09 INFO - PROCESS | 24570 | 16:26:09 INFO - PROCESS | 24570 | [#4] prototype.html Cycles:180 Average:4863.54 Median:5593.23 stddev:1445.82 (25.8%) stddev-sans-first:1408.72 16:26:09 INFO - PROCESS | 24570 | Values: 300.4 307.7 309.4 317.5 317.9 5554.5 5589.2 5599.2 5613.7 5668.8 5228.7 5348.5 5386.9 5546.8 5556.5 4203.9 4238.1 4241.7 4279.9 4280.2 4247.8 4256.3 4276.3 4276.8 4277.0 4039.4 4088.0 4122.8 4195.3 4211.2 4170.4 4173.3 4181.2 4190.6 4219.4 3683.1 3706.7 3706.8 3712.4 3738.7 5182.5 5232.7 5298.5 5311.6 5330.9 4839.9 4848.3 4870.1 4887.6 4900.9 5706.4 5744.6 5749.3 5756.3 5767.7 3970.5 4092.0 4101.8 4103.2 4119.9 5934.5 5975.9 5979.6 5981.5 5981.9 4173.8 4180.4 4197.0 4210.0 4232.2 4078.3 4257.1 4295.7 4310.7 4315.3 4910.7 4922.0 4926.3 4943.7 4944.8 5878.5 5910.5 5930.4 5939.0 5954.5 1395.5 1432.4 1456.9 1500.9 1507.8 957.6 1000.7 1015.5 1017.4 1026.8 5514.8 5564.4 5578.7 5600.6 5616.6 5955.4 5958.7 5974.3 5989.5 5990.5 5444.6 5597.3 5620.1 5629.5 5644.2 3151.8 3166.8 3169.8 3184.1 3191.4 5800.8 5999.4 6013.7 6053.5 6065.6 6013.0 6022.6 6031.8 6045.4 6052.7 6043.9 6051.7 6053.5 6070.7 6089.1 5769.2 5855.9 5925.5 5954.4 5955.3 5789.5 5814.8 5849.9 5877.6 5889.7 5838.1 6048.0 6053.6 6075.7 6080.4 4231.4 4234.3 4235.6 4243.3 4244.6 5751.5 5932.7 5944.2 5947.3 5966.6 5738.1 5898.6 5921.8 5947.9 5955.7 5872.2 5876.2 5886.8 5901.4 5925.1 5610.8 5784.4 5793.2 5798.1 5849.4 5896.5 5924.9 5939.8 5941.0 5955.2 5535.5 5762.3 5790.9 5798.6 5819.9 16:26:09 INFO - PROCESS | 24570 | 16:26:09 INFO - PROCESS | 24570 | [#5] yui.html Cycles:180 Average:13550.01 Median:24769.18 stddev:15957.61 (64.4%) stddev-sans-first:15973.12 16:26:09 INFO - PROCESS | 24570 | Values: 682.5 684.9 700.8 720.3 732.4 12368.8 12464.3 12620.6 12636.7 12659.0 10799.9 11217.4 11224.4 11269.9 11900.2 656.4 769.5 784.6 785.9 793.2 777.2 777.3 778.1 784.8 796.2 818.5 818.7 819.5 823.8 835.6 676.7 807.0 811.4 812.7 828.6 590.9 591.1 591.1 605.4 611.8 11968.8 12009.3 12014.0 12014.6 12034.9 11763.6 12469.4 12596.8 12618.1 12637.2 10262.9 10393.1 10414.5 10440.8 10546.7 3674.9 3689.6 3691.1 3847.3 3866.5 55993.0 56797.0 57484.1 57840.7 57851.7 9760.6 9814.9 9826.6 10135.1 10349.4 17654.4 17831.9 17863.3 17904.8 18120.0 7298.8 7539.1 7557.2 7621.7 7647.8 4241.7 4365.2 4366.3 4403.0 4406.0 3031.4 3126.6 3127.7 3128.3 3135.4 615.5 629.2 634.9 635.5 636.6 469.8 535.8 611.9 642.0 711.4 8229.8 8615.7 8686.7 8789.4 8945.4 687.1 695.8 706.3 712.3 713.6 3862.2 3952.6 3963.8 3999.8 4111.3 53581.5 53762.7 53817.7 54392.2 55114.7 49758.5 51142.2 51650.0 51822.5 52151.0 45132.3 46234.0 46272.8 46376.5 47149.1 7682.8 7698.6 7718.7 7761.9 7766.6 28661.3 29250.3 29977.6 30938.0 31289.5 37662.8 39977.4 41470.8 41688.0 42065.0 10727.1 10752.2 10819.4 10865.2 11018.2 11511.0 11715.9 11721.5 11732.9 11812.8 8998.8 10858.2 10919.3 11538.1 11538.8 11014.4 11184.0 11338.9 11366.0 12132.5 11350.8 11352.5 11408.3 11476.5 11986.0 9742.6 9872.2 9915.4 9999.2 10076.1 9838.9 10176.7 10250.5 10295.1 10328.1 16:26:09 INFO - PROCESS | 24570 | -------- Summary: end -------- 16:26:09 INFO - PROCESS | 24570 | 16:26:09 INFO - TEST-INFO | 24570: exit 0 16:26:09 INFO - TEST-OK | dromaeo_css | took 1111972ms 16:26:09 INFO - TEST-START | kraken 16:26:09 INFO - operating with platform_type : linux_ 16:26:09 INFO - Initialising browser for kraken test... 16:26:09 INFO - TEST-INFO | started process 24755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQvt9Y/profile http://localhost:33977/getInfo.html) 16:26:13 INFO - PROCESS | 24755 | __metrics Screen width/height:1600/1200 16:26:13 INFO - PROCESS | 24755 | colorDepth:24 16:26:13 INFO - PROCESS | 24755 | Browser inner width/height: 1024/697 16:26:13 INFO - PROCESS | 24755 | __metrics 16:26:14 ERROR - PROCESS | 24755 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:26:15 INFO - TEST-INFO | 24755: exit 0 16:26:15 INFO - Browser initialized. 16:26:15 INFO - Running cycle 1/1 for kraken test... 16:26:15 INFO - TEST-INFO | started process 24836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQvt9Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:27 INFO - PROCESS | 24836 | RSS: Main: 153198592 16:26:27 INFO - PROCESS | 24836 | 16:26:29 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33977/tests/kraken/driver.html?testName=audio-beat-detection) 16:26:30 INFO - PROCESS | 24836 | RSS: Main: 207667200 16:26:30 INFO - PROCESS | 24836 | 16:26:33 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33977/tests/kraken/driver.html?testName=audio-dft) 16:26:33 INFO - PROCESS | 24836 | RSS: Main: 192946176 16:26:33 INFO - PROCESS | 24836 | 16:26:37 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33977/tests/kraken/driver.html?testName=audio-fft) 16:26:37 INFO - PROCESS | 24836 | RSS: Main: 263282688 16:26:37 INFO - PROCESS | 24836 | 16:26:39 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33977/tests/kraken/driver.html?testName=audio-oscillator) 16:26:40 INFO - PROCESS | 24836 | RSS: Main: 172232704 16:26:40 INFO - PROCESS | 24836 | 16:26:42 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33977/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:26:43 INFO - PROCESS | 24836 | RSS: Main: 176824320 16:26:43 INFO - PROCESS | 24836 | 16:26:46 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33977/tests/kraken/driver.html?testName=imaging-darkroom) 16:26:46 INFO - PROCESS | 24836 | RSS: Main: 212918272 16:26:46 INFO - PROCESS | 24836 | 16:26:49 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33977/tests/kraken/driver.html?testName=imaging-desaturate) 16:26:50 INFO - PROCESS | 24836 | RSS: Main: 213114880 16:26:50 INFO - PROCESS | 24836 | 16:26:53 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33977/tests/kraken/driver.html?testName=json-parse-financial) 16:26:53 INFO - PROCESS | 24836 | RSS: Main: 213524480 16:26:53 INFO - PROCESS | 24836 | 16:26:55 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33977/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:26:56 INFO - PROCESS | 24836 | RSS: Main: 202416128 16:26:56 INFO - PROCESS | 24836 | 16:26:57 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33977/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:26:58 INFO - PROCESS | 24836 | RSS: Main: 203718656 16:26:58 INFO - PROCESS | 24836 | 16:27:00 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33977/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:27:01 INFO - PROCESS | 24836 | RSS: Main: 219078656 16:27:01 INFO - PROCESS | 24836 | 16:27:03 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:27:04 INFO - PROCESS | 24836 | RSS: Main: 222871552 16:27:04 INFO - PROCESS | 24836 | 16:27:07 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:27:07 INFO - PROCESS | 24836 | RSS: Main: 218001408 16:27:07 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | Cycle 1(1): loaded http://localhost:33977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33977/tests/kraken/driver.html?testName=ai-astar) 16:27:09 INFO - PROCESS | 24836 | RSS: Main: 280985600 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | __start_tp_report 16:27:09 INFO - PROCESS | 24836 | _x_x_mozilla_page_load 16:27:09 INFO - PROCESS | 24836 | _x_x_mozilla_page_load_details 16:27:09 INFO - PROCESS | 24836 | |i|pagename|runs| 16:27:09 INFO - PROCESS | 24836 | |0;ai-astar;110;112;108;110;111;114;101;115;111;111 16:27:09 INFO - PROCESS | 24836 | |1;audio-beat-detection;153;127;155;186;128;166;164;132;181;135 16:27:09 INFO - PROCESS | 24836 | |2;audio-dft;161;161;161;161;160;159;161;164;163;161 16:27:09 INFO - PROCESS | 24836 | |3;audio-fft;72;73;101;111;77;72;72;127;101;76 16:27:09 INFO - PROCESS | 24836 | |4;audio-oscillator;93;92;146;92;92;92;147;93;93;150 16:27:09 INFO - PROCESS | 24836 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;116;116;117 16:27:09 INFO - PROCESS | 24836 | |6;imaging-darkroom;146;146;145;146;145;145;145;145;146;145 16:27:09 INFO - PROCESS | 24836 | |7;imaging-desaturate;94;95;95;94;94;94;94;94;94;94 16:27:09 INFO - PROCESS | 24836 | |8;json-parse-financial;57;57;58;56;59;56;57;80;55;54 16:27:09 INFO - PROCESS | 24836 | |9;json-stringify-tinderbox;61;61;60;61;61;60;61;61;60;61 16:27:09 INFO - PROCESS | 24836 | |10;stanford-crypto-aes;76;77;76;75;78;77;78;78;78;78 16:27:09 INFO - PROCESS | 24836 | |11;stanford-crypto-ccm;136;132;125;131;134;126;128;123;154;123 16:27:09 INFO - PROCESS | 24836 | |12;stanford-crypto-pbkdf2;163;162;163;164;163;165;171;164;164;167 16:27:09 INFO - PROCESS | 24836 | |13;stanford-crypto-sha256-iterative;68;68;67;66;66;67;76;68;68;65 16:27:09 INFO - PROCESS | 24836 | __end_tp_report 16:27:09 INFO - PROCESS | 24836 | __start_cc_report 16:27:09 INFO - PROCESS | 24836 | _x_x_mozilla_cycle_collect,1608 16:27:09 INFO - PROCESS | 24836 | __end_cc_report 16:27:09 INFO - PROCESS | 24836 | __startTimestamp1460762829563__endTimestamp 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | ------- Summary: start ------- 16:27:09 INFO - PROCESS | 24836 | Number of tests: 14 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.83 (3.5%) stddev-sans-first:4.06 16:27:09 INFO - PROCESS | 24836 | Values: 110.0 112.0 108.0 110.0 111.0 114.0 101.0 115.0 111.0 111.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:159.50 stddev:21.68 (13.6%) stddev-sans-first:23.00 16:27:09 INFO - PROCESS | 24836 | Values: 153.0 127.0 155.0 186.0 128.0 166.0 164.0 132.0 181.0 135.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 16:27:09 INFO - PROCESS | 24836 | Values: 161.0 161.0 161.0 161.0 160.0 159.0 161.0 164.0 163.0 161.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#3] audio-fft Cycles:10 Average:88.20 Median:72.00 stddev:20.13 (28.0%) stddev-sans-first:20.48 16:27:09 INFO - PROCESS | 24836 | Values: 72.0 73.0 101.0 111.0 77.0 72.0 72.0 127.0 101.0 76.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:26.70 (29.0%) stddev-sans-first:27.69 16:27:09 INFO - PROCESS | 24836 | Values: 93.0 92.0 146.0 92.0 92.0 92.0 147.0 93.0 93.0 150.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:27:09 INFO - PROCESS | 24836 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 16:27:09 INFO - PROCESS | 24836 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:27:09 INFO - PROCESS | 24836 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:57.00 stddev:7.55 (13.2%) stddev-sans-first:7.98 16:27:09 INFO - PROCESS | 24836 | Values: 57.0 57.0 58.0 56.0 59.0 56.0 57.0 80.0 55.0 54.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 16:27:09 INFO - PROCESS | 24836 | Values: 61.0 61.0 60.0 61.0 61.0 60.0 61.0 61.0 60.0 61.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:78.00 stddev:1.10 (1.4%) stddev-sans-first:1.09 16:27:09 INFO - PROCESS | 24836 | Values: 76.0 77.0 76.0 75.0 78.0 77.0 78.0 78.0 78.0 78.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:131.50 stddev:9.20 (7.0%) stddev-sans-first:9.59 16:27:09 INFO - PROCESS | 24836 | Values: 136.0 132.0 125.0 131.0 134.0 126.0 128.0 123.0 154.0 123.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.00 stddev:2.63 (1.6%) stddev-sans-first:2.73 16:27:09 INFO - PROCESS | 24836 | Values: 163.0 162.0 163.0 164.0 163.0 165.0 171.0 164.0 164.0 167.0 16:27:09 INFO - PROCESS | 24836 | 16:27:09 INFO - PROCESS | 24836 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:3.03 (4.5%) stddev-sans-first:3.22 16:27:09 INFO - PROCESS | 24836 | Values: 68.0 68.0 67.0 66.0 66.0 67.0 76.0 68.0 68.0 65.0 16:27:09 INFO - PROCESS | 24836 | -------- Summary: end -------- 16:27:09 INFO - PROCESS | 24836 | 16:27:10 INFO - TEST-INFO | 24836: exit 0 16:27:10 INFO - TEST-OK | kraken | took 60599ms 16:27:10 INFO - SUITE-END | took 1172s 16:27:10 INFO - Completed test suite (00:19:32) 16:27:10 INFO - javascript benchmark 16:27:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3027.6064111665487, 3088.305131345446, 3123.6407813101487, 3123.984380078101, 3152.196189971556, 5179.870503237421, 5223.686578805275, 5228.137357336035, 5251.8949621007605, 5265.078611243036, 5212.791488340471, 5217.713025783581, 5230.581553475722, 5242.292290540776, 5263.894722105565, 4689.062187562484, 4723.527647235274, 4829.589484893788, 4871.147549178897, 4889.462159162489, 4808.567228949394, 4829.613630909536, 4851.0, 4865.41615006198, 4878.438979517347, 4676.789544470507, 4677.8830529236875, 4750.61995040396, 4794.760261986921, 4795.6163506919365, 4735.526447355272, 4778.832740854054, 4783.736894470802, 4785.976070119627, 4816.181249187612, 4589.885252868671, 4699.624030077585, 4743.739094349809, 4756.808418495594, 4823.734694591796, 5038.294638750578, 5077.974610126963, 5100.744962751847, 5102.770375333119, 5165.845024649267, 5448.45515448456, 5483.917741233885, 5493.697846618435, 5493.697846618435, 5541.27963364764, 5491.780328786844, 5539.750711218005, 5567.47109024642, 5620.297462817148, 5707.600467967244, 5166.7674954626755, 5185.222216667492, 5190.09173394662, 5241.868953276123, 5249.947500525022, 5635.492805647511, 5643.830685079454, 5645.887082258414, 5647.830565083054, 5654.85862853432, 5390.137577987503, 5410.1343784995, 5502.862428439321, 5567.66594004361, 5577.860553486195, 5586.078297080936, 5609.411011843779, 5614.466625670555, 5622.184783206494, 5624.072028115397, 5573.777048918079, 5579.497845193952, 5581.972090139605, 5583.246261754693, 5585.022621041301, 5357.491038351351, 5596.552275817925, 5658.886822263532, 5703.344115426696, 5713.914291285634, 4283.31466965284, 4285.657147428198, 4289.806958686867, 4292.163028209532, 4324.027093903909, 3780.8487660493824, 3842.9231415371537, 3850.172212974224, 3864.594217607167, 3899.922001559953, 5302.549283310885, 5314.5748340132695, 5317.202419637086, 5343.038253114477, 5366.302380690485, 5604.579656525777, 5658.122990936411, 5662.68855212959, 5663.065594176915, 5664.376918538957, 5214.97392513035, 5294.655847369909, 5322.042032434121, 5323.52088312046, 5403.243545903577, 4736.7631618418945, 4738.8341408050555, 4760.904781904343, 4800.3279540864305, 4806.711597304173, 5551.583631227593, 5624.0439125348785, 5628.296462942132, 5646.096624540136, 5674.0, 5445.264889239902, 5472.945270547403, 5511.751971161227, 5537.612367134342, 5571.860703482445, 5662.688552129673, 5682.715864206691, 5684.545236380997, 5692.089265717631, 5698.401667824819, 5463.180522921593, 5464.3442786865835, 5464.781408743605, 5466.644668096561, 5467.72661366938, 5488.56091512686, 5601.551875849841, 5642.069058605448, 5718.142278658234, 5730.770769169187, 5378.569714422759, 5389.622726409114, 5392.6225164239695, 5396.433374495621, 5399.05516534597, 5371.248025276543, 5378.435264297193, 5382.407935127055, 5387.703676297841, 5427.267318911896, 5320.893582128413, 5408.5673146149, 5454.481824226692, 5495.258140151029, 5504.422035686195, 5378.247045413567, 5384.811531596375, 5389.83830485086, 5393.6224464287125, 5402.837914862561, 5236.390470587172, 5245.0, 5260.132078207206, 5280.603954703336, 5294.179402192666], "value": 5138.56509279983, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.1391017799638, 654.2214764430324, 659.7130248341972, 660.009985022466, 666.5700623098102, 31025.0, 31767.841160794193, 37566.24867502648, 38889.41665875007, 39032.80483597578, 42946.785266073704, 42987.78506107473, 43297.78351108248, 43361.0, 43584.78207608966, 8644.740657780276, 8841.823163536757, 8843.690470833522, 8844.73465796024, 8845.557722113901, 8670.393072484929, 8769.912300876973, 8791.076936921627, 8791.428557143798, 8793.472391656522, 8798.032216456184, 8881.245094167003, 8883.73348799537, 8887.15572020657, 8888.866667, 8592.011918629343, 8610.698625548108, 8613.353998450079, 8616.310695144437, 8617.310615150804, 8668.39321247513, 8712.956435217846, 8755.343349248767, 8775.736727898173, 8782.38523303369, 39574.802125989474, 40157.0, 40163.59836401628, 40189.39715904264, 40193.59806401957, 3371.5448414463976, 3400.931981360359, 3619.6561326673923, 3803.82882770276, 3905.1994341159993, 31142.0, 32070.35859282801, 32377.190570235696, 32381.35237295241, 32403.6759632403, 4178.39413285075, 4235.724677895927, 4307.332363483665, 4312.89176348466, 4317.330813723878, 256668.0, 276165.0, 276348.99999999796, 276402.0, 276726.0, 53605.1959220612, 53768.0, 53852.46147538474, 54072.0, 54160.729196353765, 57218.42781572131, 57252.0, 57473.0, 57817.132743008886, 57846.710766445896, 14665.413383464542, 14673.192974386511, 14775.40898364075, 14811.259437028106, 14812.70374592502, 11107.500162492708, 11109.333439993465, 11122.61070862516, 11124.0, 11135.554577816958, 15486.303116359792, 15593.532194034196, 15603.375864965501, 15649.84350156484, 15664.765028524582, 6403.647799370986, 6480.740770369132, 6521.510886683518, 6555.901661475082, 6650.401463868178, 964.7636329099415, 1029.1149611334247, 1033.338663255517, 1078.9298695584762, 1104.9502772375263, 30208.852805649338, 30886.536701949488, 31802.0, 32061.839690801397, 32368.83815580907, 1023.81059503992, 1035.4615599888016, 1037.1858091398217, 1067.151614466501, 1090.8527348807968, 16174.75737863933, 16652.83347166513, 16844.831551684572, 16998.0, 17029.914850425917, 372060.0, 375511.0, 376041.0, 376191.0, 377187.0, 53778.46221537813, 54942.450575493735, 55040.72479637656, 55062.17406738902, 55212.0, 1160.7794519041356, 1279.8656141105237, 1328.4022190014339, 1399.6500874781304, 1410.4076287959083, 27755.86122069377, 31158.532622011142, 31823.204419888763, 31949.0, 32275.838620806746, 43663.345049824915, 43788.34317485177, 44282.0, 44295.335569965835, 44355.556444436435, 260795.0, 260801.0, 260968.0, 261148.0, 261315.0, 34259.0, 39156.412653809646, 40474.0, 40659.3901091478, 40988.38517422182, 39434.605653943094, 40343.596564033985, 40773.0, 40828.59171408367, 41575.37636935388, 37730.0, 37859.81070094632, 38286.6171338283, 38338.2332353357, 38530.422043668805, 36298.8185059073, 37358.25283494369, 38041.23917521689, 39160.0, 39254.41118383284, 39558.2088358237, 39797.80101099476, 40068.79965600153, 40121.59878401179, 40949.795251023555, 30223.244418888826, 30433.23916902095, 31422.0, 32318.83840580782, 35017.649823502456, 27067.046078578518, 27093.0, 27175.72824271732, 27406.45187096207, 27486.0], "value": 18729.136093563153, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.6405075305342, 391.53798517749055, 395.75463212808063, 400.47937681014685, 409.32665764816875, 17903.820961790378, 18340.541486462844, 18447.44657660269, 18456.723149152756, 19434.61130777387, 16989.0, 17057.0, 17905.7314140288, 18058.63882722348, 18100.90949545254, 5122.948770512294, 5606.495415412612, 5847.298324201101, 5860.677662728548, 5895.823125306248, 5740.483356497914, 5774.2782152230975, 5783.681897495636, 5786.479216870481, 5807.477327040566, 5687.459691329338, 5742.655440673552, 5755.647422855625, 5760.193572899798, 5762.596618236725, 5570.6657600543895, 5712.11462223356, 5735.340435849847, 5751.626144300607, 5760.049591817345, 4917.5574198321965, 5096.821611243588, 5139.640225184238, 5145.665531740462, 5149.639525233235, 19457.902710486356, 21570.1371945122, 23097.769022309898, 23434.296971090895, 23442.296731098093, 2145.5279838435517, 2193.8573992690585, 2220.4670878989086, 2421.285720712394, 2982.806117602349, 14068.507602233873, 14135.575932722035, 14275.78586321206, 14350.425982960669, 14601.634959126, 1944.7957964413815, 1954.5699946011855, 2024.7772744998185, 2026.7973202679761, 2046.6213750456063, 76660.61669691616, 76840.0, 77865.0, 78752.60623696845, 79226.60386698088, 10301.845472317922, 10418.895811041793, 10421.218408619385, 10539.94730026345, 10642.594369801744, 14823.110613363233, 14886.702265954837, 14891.553253402415, 14899.255037248095, 14916.254187290591, 7357.52176108562, 7465.962670186615, 7561.09266887977, 7681.462297639224, 7694.0, 7163.928360716431, 7195.352418282379, 7276.745313913988, 7292.8906066409045, 7293.598852063082, 6443.548951573439, 6499.2850786413455, 6590.0, 6591.274959754423, 6635.668216589152, 1871.1579789094963, 1922.1542521290587, 1937.1960636335764, 1957.0312695215675, 1971.4184315626924, 954.2556805691572, 1038.1487180511908, 1061.9150467962545, 1085.4898197846999, 1114.2812885688686, 18939.90530047341, 19277.90361048186, 19296.517587060156, 19455.513612159528, 19459.90270048669, 1005.8390657494766, 1011.2415688233824, 1015.8984101589782, 1030.860833787444, 1030.891756365571, 10115.645952391631, 10599.516067750521, 10713.78572428547, 10897.346159230472, 11287.0, 462665.0, 467147.0, 468391.0, 469251.0, 481106.0, 89917.0, 91003.54498227598, 91104.0, 92186.53906730423, 92228.0, 1028.6091285311534, 1032.2516175772655, 1065.8294672852307, 1066.5893630951985, 1072.7210925159359, 16929.238184281985, 16990.0, 17164.882481918507, 17177.656446871242, 17281.39515116965, 37037.0, 37528.437073443376, 37540.24919501649, 37553.43669845009, 37686.55037422559, 52782.0, 54901.45098548963, 55234.0, 55459.722701386236, 55568.72215638896, 8014.599270036591, 8066.395020373378, 8072.838543228985, 8300.70947516834, 8356.289715374262, 9099.272058235192, 12660.683482913, 13060.477580896657, 13119.0, 13180.604581862559, 11557.537698492302, 11699.0, 11712.180147389601, 11840.70398240051, 12014.75970480603, 11211.495482703462, 11627.244229125079, 11774.116941229271, 11780.05759539252, 11781.0, 11376.317420954769, 11838.230515016496, 11936.220941784155, 12077.818832717341, 12294.262344259372, 7919.0, 8090.87863682057, 8192.467489613156, 8309.83380332378, 8838.513881736566, 8503.0, 10975.0, 11835.940820295844, 11897.643070707893, 11946.581869634521], "value": 9187.03661052219, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.2421981580412, 1432.641839540115, 1488.2261224163433, 1551.1623723189477, 1719.3122750899647, 7116.4306855451505, 7965.402594805391, 8130.186981301867, 8166.346692264619, 8169.795755106125, 7844.372450203984, 8010.879836802453, 8022.0, 8026.157253488373, 8028.036635603736, 1976.7529058867642, 2286.599845027122, 2312.2138472919246, 2342.8008619267384, 2350.059976009593, 2285.6228722260807, 2326.5579539887367, 2337.532493501298, 2349.119080344871, 2353.2587235020915, 2240.529488807352, 2272.704548408713, 2272.977270227293, 2273.102124660758, 2278.7835155660187, 1971.1327016112937, 2217.84475086744, 2269.920552780645, 2278.7835155660187, 2284.5088306014122, 2186.3222401055564, 2188.5513469738667, 2190.452386903274, 2198.8131008864266, 2267.784560466753, 8109.75670729879, 8245.79385515367, 8248.381371397169, 8256.339492840558, 8259.091499935003, 5013.0, 5186.688798672092, 5204.68771873685, 5214.374275086976, 5217.6608520446425, 3206.5350524174096, 3244.821534815584, 3296.175956010997, 3377.257003459235, 3396.932061358759, 1065.387402243713, 1082.4804094034828, 1083.783243351325, 1108.944552772358, 1115.297362661518, 11643.476043578059, 11661.883381166164, 11672.649820505398, 11689.941550292195, 11692.473838677195, 4427.158839820424, 4433.246348120827, 4600.700954437951, 4627.768611569475, 4634.397528321364, 9844.114029737215, 9846.409215447096, 9853.704388868202, 9858.753531161778, 9866.112049915542, 4318.676099292566, 5216.400113986864, 5218.034663587248, 5226.8954620908125, 5249.632525723163, 4577.679562430664, 4655.883602909955, 4670.042641258534, 4682.250839865674, 4682.765861706969, 3878.9418158727076, 3911.6088391161225, 3997.4809572362897, 4024.2957482440456, 4052.3111071117983, 1238.7894058009979, 1277.0677405493855, 1291.9741605167844, 1301.1607513153963, 1306.0857399820163, 738.8891666250106, 865.4634126841398, 899.9010108888017, 902.5397047505688, 905.2591007693667, 5616.157576363578, 5651.265335506358, 5734.971325143348, 5871.4715675589405, 5892.7642894283745, 946.7254496196164, 965.6958058211641, 1014.7970405918845, 1042.3381152967768, 1046.3617193511952, 3814.809259537012, 3831.6743076838225, 3842.212346468967, 3867.0525721197923, 3899.9610003899597, 10457.058864702061, 10726.0, 10781.514831832586, 10796.0, 10812.837807432894, 10642.680719578426, 10672.306300090624, 10694.358338499715, 10708.732281692864, 10731.356118632906, 7528.644843928036, 7677.884831727529, 7733.4973226740085, 7893.092294386104, 7930.881036784453, 5506.540766696909, 5529.474699903502, 5563.638363506359, 5572.247746554163, 5687.658740475585, 9559.569819358006, 9644.855327169958, 9755.21958243353, 9876.604935802487, 9881.160101391462, 9570.0, 9814.803703926023, 9937.552810123418, 9954.25343099256, 9996.750081248027, 6329.683515824282, 6955.269696681978, 7061.8940715888275, 7536.171021187774, 7778.611069446391, 7948.0859701132795, 7966.482178658601, 8025.759227223192, 8043.235892590194, 8047.758567242992, 7035.648217589202, 7223.783286501413, 7245.963770181326, 7290.635468226461, 7307.26927307265, 6850.862982740417, 6854.485913556603, 6981.092457980633, 7074.646267686698, 7241.927580724126, 6396.32838551964, 6498.512611554058, 6504.73981040772, 6511.446527045254, 6512.5766825156215, 4883.267509873547, 4930.359053323045, 5049.84850454487, 5079.238114282887, 5188.0661480933795, 5173.248910172261, 5187.548692195796, 5192.844214673566, 5290.153575428067, 5297.443768404416], "value": 4459.832914760746, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.4486766782953, 307.6938446245985, 309.38123752495005, 317.46507135476725, 317.934823361211, 5554.527865131464, 5589.161625756134, 5599.160125981105, 5613.663180209191, 5668.829935101953, 5228.73856307185, 5348.491893270133, 5386.8922621547545, 5546.807436401173, 5556.472135147164, 4203.936940945889, 4238.088810905662, 4241.6818738594575, 4279.893002674942, 4280.208161490134, 4247.766372849492, 4256.34026725858, 4276.273033584298, 4276.786160691969, 4276.978615106936, 4039.4142849286836, 4087.9780054986254, 4122.752634841904, 4195.349720793282, 4211.241976444238, 4170.35359519275, 4173.269677806372, 4181.18118618402, 4190.601892820192, 4219.43037689911, 3683.079230192452, 3706.684931780802, 3706.759060661075, 3712.3874560697454, 3738.6633354153655, 5182.455842136596, 5232.659877107976, 5298.496642818926, 5311.601629877775, 5330.946690533084, 4839.927401088987, 4848.2727590861305, 4870.09903167915, 4887.584555312803, 4900.8774780630765, 5706.400827913092, 5744.597878148531, 5749.31008279005, 5756.309242890838, 5767.711614419304, 3970.463987361698, 4091.97954010228, 4101.835926562934, 4103.179364127186, 4119.938200926958, 5934.5252379809945, 5975.9103613445395, 5979.611325263844, 5981.461668449817, 5981.940180598225, 4173.812178451977, 4180.435641188462, 4196.979015104966, 4210.031692710632, 4232.217039847576, 4078.2659121358442, 4257.084726783756, 4295.699301048959, 4310.719803212781, 4315.266404711144, 4910.680805747615, 4921.975390123098, 4926.261060840902, 4943.728094954812, 4944.777485013183, 5878.5297176225795, 5910.468057874812, 5930.43660852227, 5939.0, 5954.523638108941, 1395.5045958684723, 1432.3912337256625, 1456.8543145685346, 1500.9399624015136, 1507.773833924898, 957.6456711016968, 1000.7298029531986, 1015.4516561056946, 1017.3793985668736, 1026.810040142576, 5514.751836167302, 5564.4141419696, 5578.665280083208, 5600.551955843523, 5616.634918730269, 5955.434233747787, 5958.702064896738, 5974.312954010345, 5989.520838332923, 5990.490808281258, 5444.6188766785945, 5597.3003374578175, 5620.1288800236025, 5629.493345598834, 5644.181593668895, 3151.842407879597, 3166.7649616649524, 3169.793963392372, 3184.076617780864, 3191.4095892260007, 5800.796972105956, 5999.400059993965, 6013.729382177812, 6053.4551890330085, 6065.575409721366, 6013.045760127889, 6022.638641681513, 6031.788887388921, 6045.425684559959, 6052.66710330936, 6043.939560604425, 6051.667158306335, 6053.545984051214, 6070.696465176812, 6089.147519347206, 5769.22115514417, 5855.882882342415, 5925.52595792327, 5954.374790647093, 5955.255593050869, 5789.507891829242, 5814.796482123105, 5849.912251316318, 5877.559997800567, 5889.734961926809, 5838.072351498231, 6047.969760151171, 6053.606515576474, 6075.665838378932, 6080.3615620361, 4231.449911511484, 4234.280172370766, 4235.597618226264, 4243.257429949685, 4244.617984381297, 5751.482366587027, 5932.673702946379, 5944.227250457413, 5947.286325640951, 5966.552508561962, 5738.139279108167, 5898.616589921641, 5921.822345329647, 5947.881042379215, 5955.6724380157775, 5872.20897626211, 5876.206712093813, 5886.823395298148, 5901.350851406428, 5925.111233315038, 5610.831675049755, 5784.421557844182, 5793.159991801081, 5798.072308430631, 5849.415058494116, 5896.49879760208, 5924.911126333022, 5939.762409503572, 5941.009761729869, 5955.166276721349, 5535.501804837584, 5762.279715035621, 5790.855228619318, 5798.59409841307, 5819.854503637443], "value": 4392.941487442079, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.5256446769491, 684.8561802021575, 700.8493173967596, 720.2977097330103, 732.4177279063148, 12368.814467782979, 12464.252144871303, 12620.558280460185, 12636.684082897933, 12659.0, 10799.892001079987, 11217.383043932581, 11224.382658953755, 11269.887301126986, 11900.226485278472, 656.3600489522725, 769.4729110559285, 784.5528049012065, 785.9371250299962, 793.2345286798225, 777.2421888658541, 777.3237283563279, 778.0702061037063, 784.827337985645, 796.2197046894047, 818.4639061414783, 818.7461886815076, 819.5205804604313, 823.7734622978699, 835.6239692138531, 676.6921050921843, 806.9677212911477, 811.3914564076942, 812.7317985064915, 828.6436832162168, 590.946814786667, 591.0985746736219, 591.131037375058, 605.4278706622243, 611.8378629663143, 11968.82046769299, 12009.279443233347, 12014.0, 12014.639560813102, 12034.939825300817, 11763.588274410355, 12469.376531173495, 12596.81104783429, 12618.116731828775, 12637.20757519495, 10262.9486852566, 10393.064624183784, 10414.479276036167, 10440.79118417635, 10546.736331591695, 3674.9081272968124, 3689.6494832990825, 3691.1141326081815, 3847.3459511883048, 3866.516685414323, 55993.0, 56797.0, 57484.13773793438, 57840.71079644617, 57851.71074144644, 9760.560774765152, 9814.901850981541, 9826.557804898797, 10135.138513226311, 10349.379037257788, 17654.382096626556, 17831.910840445973, 17863.28546858111, 17904.820951790574, 18120.0, 7298.781036568911, 7539.132999705104, 7557.168711441737, 7621.69513219465, 7647.808804779925, 4241.745495270294, 4365.170617582649, 4366.257736184856, 4403.0, 4406.030673251944, 3031.4088752693015, 3126.609173853268, 3127.702868227515, 3128.2804954860508, 3135.3885992231294, 615.4583966109794, 629.2134831460675, 634.8857205702925, 635.5138319185827, 636.6339354870968, 469.79329095198005, 535.7749745106986, 611.9082137679384, 641.9967900160469, 711.4095300900241, 8229.753107406787, 8615.6984505542, 8686.73939781795, 8789.428687135316, 8945.37382383227, 687.0621601513998, 695.8399568099366, 706.2901783707341, 712.2877122877123, 713.5575942915426, 3862.1503269280715, 3952.604739526082, 3963.8018099095507, 3999.7600143991453, 4111.321631930758, 53581.464185358425, 53762.731186343815, 53817.73091134519, 54392.18411723827, 55114.724426378416, 49758.50241497611, 51142.23286650703, 51650.0, 51822.48177518177, 52151.0, 45132.3230151548, 46234.0, 46272.7686361566, 46376.5362346379, 47149.05701885943, 7682.785608752936, 7698.615069246403, 7718.691252349843, 7761.883571746541, 7766.611669416619, 28661.28346791347, 29250.268743281587, 29977.550336745404, 30938.0, 31289.530657039708, 37662.81168594139, 39977.400338994354, 41470.79264603658, 41688.0, 42065.0, 10727.141828653845, 10752.193585480964, 10819.404932728776, 10865.239433239598, 11018.228723989243, 11511.0, 11715.882841171479, 11721.472533736172, 11732.88267117352, 11812.763744724885, 8998.82002359936, 10858.185636077167, 10919.342020423248, 11538.07695384384, 11538.82691759641, 11014.44927753625, 11184.0, 11338.94330528375, 11366.0, 12132.514699412277, 11350.772984540428, 11352.489137988645, 11408.315501069963, 11476.540938362372, 11986.041116710468, 9742.610295588098, 9872.160866326443, 9915.355501892354, 9999.150072243941, 10076.143527799926, 9838.9016109838, 10176.745581360525, 10250.53872575721, 10295.12491438236, 10328.070473657406], "value": 6167.928952381216, "unit": "score"}], "name": "dromaeo_css", "value": 6888.6157747476755, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 108.0, 110.0, 111.0, 114.0, 101.0, 115.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 155.0, 186.0, 128.0, 166.0, 164.0, 132.0, 181.0, 135.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 159.0, 161.0, 164.0, 163.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 101.0, 111.0, 77.0, 72.0, 72.0, 127.0, 101.0, 76.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 146.0, 92.0, 92.0, 92.0, 147.0, 93.0, 93.0, 150.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 56.0, 59.0, 56.0, 57.0, 80.0, 55.0, 54.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 75.0, 78.0, 77.0, 78.0, 78.0, 78.0, 78.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 125.0, 131.0, 134.0, 126.0, 128.0, 123.0, 154.0, 123.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 164.0, 163.0, 165.0, 171.0, 164.0, 164.0, 167.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 66.0, 66.0, 67.0, 76.0, 68.0, 68.0, 65.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1537.9, "alertThreshold": 2.0}]} 16:27:10 INFO - Return code: 0 16:27:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:27:10 ERROR - # TBPL SUCCESS # 16:27:10 INFO - Running post-action listener: _resource_record_post_action 16:27:10 INFO - Running post-run listener: _resource_record_post_run 16:27:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536612864; Read time: 16; Write time: 431900 16:27:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244158464; Read time: 0; Write time: 231864 16:27:11 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292454400; Read time: 16; Write time: 200036 16:27:11 INFO - Running post-run listener: _upload_blobber_files 16:27:11 INFO - Blob upload gear active. 16:27:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:27:11 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 16:27:11 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'] 16:27:11 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 16:27:12 INFO - (blobuploader) - INFO - Open directory for files ... 16:27:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:27:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:27:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:13 INFO - (blobuploader) - INFO - Done attempting. 16:27:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:27:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:27:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:14 INFO - (blobuploader) - INFO - Done attempting. 16:27:14 INFO - (blobuploader) - INFO - Iteration through files over. 16:27:14 INFO - Return code: 0 16:27:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:27:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:27:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0f5210e22a3ecdc8ac386e06c4be6467f847dd03512b686b0f8b6aa89b56746a61f295e67daed16f2bfa8b88fc30413ce9309413d24c08e5993fee42994ede7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8da20c5d8acd0c0475dc458b4486e55def0e3ade6057d65f801a4fc98ee58b62294b3f0a219c7f9e67cfdd1411ce5cb66acb124dd8441bd27853e0a899b50ef6"} 16:27:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:27:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:27:14 INFO - Contents: 16:27:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0f5210e22a3ecdc8ac386e06c4be6467f847dd03512b686b0f8b6aa89b56746a61f295e67daed16f2bfa8b88fc30413ce9309413d24c08e5993fee42994ede7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8da20c5d8acd0c0475dc458b4486e55def0e3ade6057d65f801a4fc98ee58b62294b3f0a219c7f9e67cfdd1411ce5cb66acb124dd8441bd27853e0a899b50ef6"} 16:27:14 INFO - Running post-run listener: copy_logs_to_upload_dir 16:27:14 INFO - Copying logs to upload dir... 16:27:14 INFO - mkdir: /builds/slave/test/build/upload/logs 16:27:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.205665 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-15 16:27:14.017203) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 16:27:14.020387) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530 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/a0f5210e22a3ecdc8ac386e06c4be6467f847dd03512b686b0f8b6aa89b56746a61f295e67daed16f2bfa8b88fc30413ce9309413d24c08e5993fee42994ede7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8da20c5d8acd0c0475dc458b4486e55def0e3ade6057d65f801a4fc98ee58b62294b3f0a219c7f9e67cfdd1411ce5cb66acb124dd8441bd27853e0a899b50ef6"} build_url:https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/JFDbskMuTk2U5isq6_KlJA/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/a0f5210e22a3ecdc8ac386e06c4be6467f847dd03512b686b0f8b6aa89b56746a61f295e67daed16f2bfa8b88fc30413ce9309413d24c08e5993fee42994ede7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8da20c5d8acd0c0475dc458b4486e55def0e3ade6057d65f801a4fc98ee58b62294b3f0a219c7f9e67cfdd1411ce5cb66acb124dd8441bd27853e0a899b50ef6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 16:27:14.044581) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:27:14.044901) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460752197.885967-1953287530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 16:27:14.130788) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 16:27:14.131105) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 16:27:14.131389) ========= ========= Total master_lag: 0.26 =========