builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1461191533.32 results: success (0) buildid: 20160420141806 builduid: b804f05c0eda45409d39e1075aa20396 revision: 4feb4dd910a5a2d3061dbdd376a80975206819c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:13.321322) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:13.321735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:13.322067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:13.350375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:13.350669) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 15:32:13-- 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% 47.2M=0s 2016-04-20 15:32:13 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:13.470462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:13.470828) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016353 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:13.522989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 15:32:13.523407) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4feb4dd910a5a2d3061dbdd376a80975206819c6 --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 4feb4dd910a5a2d3061dbdd376a80975206819c6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 15:32:13,594 truncating revision to first 12 chars 2016-04-20 15:32:13,594 Setting DEBUG logging. 2016-04-20 15:32:13,594 attempt 1/10 2016-04-20 15:32:13,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4feb4dd910a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 15:32:14,474 unpacking tar archive at: mozilla-central-4feb4dd910a5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.153846 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 15:32:14.691281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:14.691749) ========= script_repo_revision: 4feb4dd910a5a2d3061dbdd376a80975206819c6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:14.692429) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:14.692774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:32:14.701487) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-20 15:32:14.701801) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:32:14 INFO - MultiFileLogger online at 20160420 15:32:14 in /builds/slave/test 15:32:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:32:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:32:14 INFO - {'append_to_log': False, 15:32:14 INFO - 'base_work_dir': '/builds/slave/test', 15:32:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:32:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:32:14 INFO - 'branch': 'Firefox-Non-PGO', 15:32:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:32:14 INFO - 'config_files': ('talos/linux_config.py',), 15:32:14 INFO - 'default_actions': ('clobber', 15:32:14 INFO - 'read-buildbot-config', 15:32:14 INFO - 'download-and-extract', 15:32:14 INFO - 'populate-webroot', 15:32:14 INFO - 'create-virtualenv', 15:32:14 INFO - 'install', 15:32:14 INFO - 'run-tests'), 15:32:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:32:14 INFO - 'download_minidump_stackwalk': True, 15:32:14 INFO - 'download_symbols': 'ondemand', 15:32:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:32:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:32:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:32:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:32:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:32:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:32:14 INFO - 'installer_path': 'installer.exe', 15:32:14 INFO - 'log_level': 'info', 15:32:14 INFO - 'log_name': 'talos', 15:32:14 INFO - 'log_to_console': True, 15:32:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:32:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:32:14 INFO - 'opt_config_files': (), 15:32:14 INFO - 'pip_index': False, 15:32:14 INFO - 'sps_profile': False, 15:32:14 INFO - 'sps_profile_interval': 0, 15:32:14 INFO - 'suite': 'dromaeojs', 15:32:14 INFO - 'system_bits': '32', 15:32:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:32:14 INFO - 'title': 'talos-linux64-ix-028', 15:32:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:32:14 INFO - 'use_talos_json': True, 15:32:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:32:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:32:14 INFO - 'work_dir': 'build'} 15:32:14 INFO - ##### 15:32:14 INFO - ##### Running clobber step. 15:32:14 INFO - ##### 15:32:14 INFO - Running pre-action listener: _resource_record_pre_action 15:32:14 INFO - Running main action method: clobber 15:32:14 INFO - rmtree: /builds/slave/test/build 15:32:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:32:15 INFO - Running post-action listener: _resource_record_post_action 15:32:15 INFO - ##### 15:32:15 INFO - ##### Running read-buildbot-config step. 15:32:15 INFO - ##### 15:32:15 INFO - Running pre-action listener: _resource_record_pre_action 15:32:15 INFO - Running main action method: read_buildbot_config 15:32:15 INFO - Using buildbot properties: 15:32:15 INFO - { 15:32:15 INFO - "project": "", 15:32:15 INFO - "product": "firefox", 15:32:15 INFO - "script_repo_revision": "production", 15:32:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:32:15 INFO - "repository": "", 15:32:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:32:15 INFO - "buildid": "20160420141806", 15:32:15 INFO - "pgo_build": "False", 15:32:15 INFO - "basedir": "/builds/slave/test", 15:32:15 INFO - "buildnumber": 553, 15:32:15 INFO - "slavename": "talos-linux64-ix-028", 15:32:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:32:15 INFO - "platform": "ubuntu64_hw", 15:32:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:32:15 INFO - "branch": "mozilla-central", 15:32:15 INFO - "repo_path": "mozilla-central", 15:32:15 INFO - "revision": "4feb4dd910a5a2d3061dbdd376a80975206819c6", 15:32:15 INFO - "stage_platform": "linux64", 15:32:15 INFO - "builduid": "b804f05c0eda45409d39e1075aa20396", 15:32:15 INFO - "slavebuilddir": "test" 15:32:15 INFO - } 15:32:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:32:15 INFO - Running post-action listener: _resource_record_post_action 15:32:15 INFO - ##### 15:32:15 INFO - ##### Running download-and-extract step. 15:32:15 INFO - ##### 15:32:15 INFO - Running pre-action listener: _resource_record_pre_action 15:32:15 INFO - Running main action method: download_and_extract 15:32:15 INFO - mkdir: /builds/slave/test/build/tests 15:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:15 INFO - https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:25 INFO - Downloaded 1361 bytes. 15:32:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:32:25 INFO - Using the following test package requirements: 15:32:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:32:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:32:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:32:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'jsshell-linux-x86_64.zip'], 15:32:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:32:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:32:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:32:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:32:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:32:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:32:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:32:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:32:25 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')]} 15:32:25 INFO - https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:32:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:32:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:32:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:28 INFO - Downloaded 22274940 bytes. 15:32:28 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'] 15:32:28 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 15:32:29 INFO - Return code: 0 15:32:29 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 15:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:29 INFO - https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:33 INFO - Downloaded 22274940 bytes. 15:32:33 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'] 15:32:33 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 15:32:35 INFO - Return code: 0 15:32:35 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')]} 15:32:35 INFO - https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:36 INFO - Downloaded 10845952 bytes. 15:32:36 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'] 15:32:36 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 15:32:36 INFO - Return code: 0 15:32: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')]} 15:32:36 INFO - https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:32:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:32:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:32:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LK_qrQCoSk2ArQA5DyvTaw/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 15:32:38 INFO - Downloaded 54610685 bytes. 15:32:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:32:38 INFO - mkdir: /builds/slave/test/properties 15:32:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:32:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:32:38 INFO - Contents: 15:32:38 INFO - build_url:https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:32:39 INFO - Running post-action listener: _resource_record_post_action 15:32:39 INFO - Running post-action listener: set_extra_try_arguments 15:32:39 INFO - ##### 15:32:39 INFO - ##### Running populate-webroot step. 15:32:39 INFO - ##### 15:32:39 INFO - Running pre-action listener: _resource_record_pre_action 15:32:39 INFO - Running main action method: populate_webroot 15:32:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:39 INFO - '--tppagecycles', 15:32:39 INFO - '7'], 15:32:39 INFO - 'tests': ['tsvgm']}}, 15:32:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:32:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:32:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:32:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:39 INFO - 'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:39 INFO - 'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['damp', 'tps']}, 15:32:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:39 INFO - 'tests': ['damp', 'tps']}, 15:32:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['dromaeo_dom']}, 15:32:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other-e10s': {'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['tsvgx', 15:32:39 INFO - 'tsvgr_opacity', 15:32:39 INFO - 'tart', 15:32:39 INFO - 'tscrollx', 15:32:39 INFO - 'cart']}, 15:32:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:32:39 INFO - 'tsvgr_opacity', 15:32:39 INFO - 'tart', 15:32:39 INFO - 'tscrollx', 15:32:39 INFO - 'cart']}, 15:32:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:39 INFO - 'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['tp5o']}, 15:32:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:39 INFO - 'tests': ['tp5o']}, 15:32:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:39 INFO - 'talos_options': ['--disable-e10s', 15:32:39 INFO - '--xperf_path', 15:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:39 INFO - 'tests': ['tp5n']}, 15:32:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:39 INFO - 'talos_options': ['--xperf_path', 15:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:39 INFO - 'tests': ['tp5n']}}, 15:32:39 INFO - 'talos.zip': {'path': '', 15:32:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:39 INFO - Running post-action listener: _resource_record_post_action 15:32:39 INFO - ##### 15:32:39 INFO - ##### Running create-virtualenv step. 15:32:39 INFO - ##### 15:32:39 INFO - Running pre-action listener: _resource_record_pre_action 15:32:39 INFO - Running main action method: create_virtualenv 15:32:39 INFO - Creating virtualenv /builds/slave/test/build/venv 15:32:39 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 15:32:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:32:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:32:39 INFO - Using real prefix '/usr' 15:32:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:32:40 INFO - Installing distribute.............................................................................................................................................................................................done. 15:32:42 INFO - Installing pip.................done. 15:32:42 INFO - Return code: 0 15:32:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:42 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 0x7f4d99d16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', '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 15:32:42 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 15:32:42 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 15:32:42 INFO - Using env: {'DISPLAY': ':0', 15:32:42 INFO - 'HOME': '/home/cltbld', 15:32:42 INFO - 'LANG': 'en_US.UTF-8', 15:32:42 INFO - 'LANGUAGE': 'en_US:en', 15:32:42 INFO - 'LOGNAME': 'cltbld', 15:32:42 INFO - 'MAIL': '/var/mail/cltbld', 15:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:42 INFO - 'MOZ_NO_REMOTE': '1', 15:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:42 INFO - 'NO_EM_RESTART': '1', 15:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:42 INFO - 'PWD': '/builds/slave/test', 15:32:42 INFO - 'SHELL': '/bin/bash', 15:32:42 INFO - 'SHLVL': '1', 15:32:42 INFO - 'TERM': 'linux', 15:32:42 INFO - 'TMOUT': '86400', 15:32:42 INFO - 'USER': 'cltbld', 15:32:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:42 INFO - '_': '/tools/buildbot/bin/python'} 15:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:42 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 15:32:42 INFO - Cleaning up... 15:32:42 INFO - Return code: 0 15:32:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:42 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 0x7f4d99d16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', '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 15:32:42 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 15:32:42 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 15:32:42 INFO - Using env: {'DISPLAY': ':0', 15:32:42 INFO - 'HOME': '/home/cltbld', 15:32:42 INFO - 'LANG': 'en_US.UTF-8', 15:32:42 INFO - 'LANGUAGE': 'en_US:en', 15:32:42 INFO - 'LOGNAME': 'cltbld', 15:32:42 INFO - 'MAIL': '/var/mail/cltbld', 15:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:42 INFO - 'MOZ_NO_REMOTE': '1', 15:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:42 INFO - 'NO_EM_RESTART': '1', 15:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:42 INFO - 'PWD': '/builds/slave/test', 15:32:42 INFO - 'SHELL': '/bin/bash', 15:32:42 INFO - 'SHLVL': '1', 15:32:42 INFO - 'TERM': 'linux', 15:32:42 INFO - 'TMOUT': '86400', 15:32:42 INFO - 'USER': 'cltbld', 15:32:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:42 INFO - '_': '/tools/buildbot/bin/python'} 15:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:42 INFO - Downloading/unpacking psutil>=0.7.1 15:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:32:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:44 INFO - Installing collected packages: psutil 15:32:44 INFO - Running setup.py install for psutil 15:32:44 INFO - building 'psutil._psutil_linux' extension 15:32:44 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 15:32:44 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 15:32:44 INFO - building 'psutil._psutil_posix' extension 15:32:44 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 15:32:44 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 15:32:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:45 INFO - Successfully installed psutil 15:32:45 INFO - Cleaning up... 15:32:45 INFO - Return code: 0 15:32:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:45 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 0x7f4d99d16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', '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 15:32:45 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 15:32:45 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 15:32:45 INFO - Using env: {'DISPLAY': ':0', 15:32:45 INFO - 'HOME': '/home/cltbld', 15:32:45 INFO - 'LANG': 'en_US.UTF-8', 15:32:45 INFO - 'LANGUAGE': 'en_US:en', 15:32:45 INFO - 'LOGNAME': 'cltbld', 15:32:45 INFO - 'MAIL': '/var/mail/cltbld', 15:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:45 INFO - 'MOZ_NO_REMOTE': '1', 15:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:45 INFO - 'NO_EM_RESTART': '1', 15:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:45 INFO - 'PWD': '/builds/slave/test', 15:32:45 INFO - 'SHELL': '/bin/bash', 15:32:45 INFO - 'SHLVL': '1', 15:32:45 INFO - 'TERM': 'linux', 15:32:45 INFO - 'TMOUT': '86400', 15:32:45 INFO - 'USER': 'cltbld', 15:32:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:45 INFO - '_': '/tools/buildbot/bin/python'} 15:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:32:45 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 15:32:45 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 15:32:45 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 15:32:45 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 15:32:45 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 15:32:45 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 15:32:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:32:47 INFO - Installing collected packages: mozsystemmonitor 15:32:47 INFO - Running setup.py install for mozsystemmonitor 15:32:47 INFO - Successfully installed mozsystemmonitor 15:32:47 INFO - Cleaning up... 15:32:47 INFO - Return code: 0 15:32:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:47 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 0x7f4d99d16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', '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 15:32:47 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 15:32:47 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 15:32:47 INFO - Using env: {'DISPLAY': ':0', 15:32:47 INFO - 'HOME': '/home/cltbld', 15:32:47 INFO - 'LANG': 'en_US.UTF-8', 15:32:47 INFO - 'LANGUAGE': 'en_US:en', 15:32:47 INFO - 'LOGNAME': 'cltbld', 15:32:47 INFO - 'MAIL': '/var/mail/cltbld', 15:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:47 INFO - 'MOZ_NO_REMOTE': '1', 15:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:47 INFO - 'NO_EM_RESTART': '1', 15:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:47 INFO - 'PWD': '/builds/slave/test', 15:32:47 INFO - 'SHELL': '/bin/bash', 15:32:47 INFO - 'SHLVL': '1', 15:32:47 INFO - 'TERM': 'linux', 15:32:47 INFO - 'TMOUT': '86400', 15:32:47 INFO - 'USER': 'cltbld', 15:32:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:47 INFO - '_': '/tools/buildbot/bin/python'} 15:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:49 INFO - Downloading blobuploader-1.2.4.tar.gz 15:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:32:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:32:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 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 15:32:49 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 15:32:50 INFO - Downloading docopt-0.6.1.tar.gz 15:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:32:50 INFO - Installing collected packages: blobuploader, requests, docopt 15:32:50 INFO - Running setup.py install for blobuploader 15:32:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:32:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:32:50 INFO - Running setup.py install for requests 15:32:50 INFO - Running setup.py install for docopt 15:32:50 INFO - Successfully installed blobuploader requests docopt 15:32:50 INFO - Cleaning up... 15:32:50 INFO - Return code: 0 15:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:50 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 0x7f4d99d16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', '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 15:32:50 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 15:32:50 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 15:32:50 INFO - Using env: {'DISPLAY': ':0', 15:32:50 INFO - 'HOME': '/home/cltbld', 15:32:50 INFO - 'LANG': 'en_US.UTF-8', 15:32:50 INFO - 'LANGUAGE': 'en_US:en', 15:32:50 INFO - 'LOGNAME': 'cltbld', 15:32:50 INFO - 'MAIL': '/var/mail/cltbld', 15:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:50 INFO - 'MOZ_NO_REMOTE': '1', 15:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:50 INFO - 'NO_EM_RESTART': '1', 15:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:50 INFO - 'PWD': '/builds/slave/test', 15:32:50 INFO - 'SHELL': '/bin/bash', 15:32:50 INFO - 'SHLVL': '1', 15:32:50 INFO - 'TERM': 'linux', 15:32:50 INFO - 'TMOUT': '86400', 15:32:50 INFO - 'USER': 'cltbld', 15:32:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:50 INFO - '_': '/tools/buildbot/bin/python'} 15:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:50 INFO - Running setup.py (path:/tmp/pip-K9Gui3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:51 INFO - Running setup.py (path:/tmp/pip-fmnDLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:51 INFO - Running setup.py (path:/tmp/pip-zBYNMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:51 INFO - Running setup.py (path:/tmp/pip-sbRPvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:51 INFO - Running setup.py (path:/tmp/pip-kIjrHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:51 INFO - Running setup.py (path:/tmp/pip-G0Iog6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:51 INFO - Running setup.py (path:/tmp/pip-lEKxlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:51 INFO - Running setup.py (path:/tmp/pip-96lP2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:51 INFO - Running setup.py (path:/tmp/pip-Zg5Eng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:51 INFO - Running setup.py (path:/tmp/pip-2iSY3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:51 INFO - Running setup.py (path:/tmp/pip-ZsqFRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:51 INFO - Running setup.py (path:/tmp/pip-rilQMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:51 INFO - Running setup.py (path:/tmp/pip-dn0G2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:51 INFO - Running setup.py (path:/tmp/pip-eeHNHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:52 INFO - Running setup.py (path:/tmp/pip-cZxIK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:52 INFO - Running setup.py (path:/tmp/pip-duYBML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:52 INFO - Running setup.py (path:/tmp/pip-FKH8oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:32:52 INFO - Running setup.py install for manifestparser 15:32:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Running setup.py install for mozcrash 15:32:52 INFO - Running setup.py install for mozdebug 15:32:52 INFO - Running setup.py install for mozdevice 15:32:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Running setup.py install for mozfile 15:32:52 INFO - Running setup.py install for mozhttpd 15:32:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Running setup.py install for mozinfo 15:32:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Running setup.py install for mozInstall 15:32:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Running setup.py install for mozleak 15:32:53 INFO - Running setup.py install for mozlog 15:32:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Running setup.py install for moznetwork 15:32:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Running setup.py install for mozprocess 15:32:53 INFO - Running setup.py install for mozprofile 15:32:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Running setup.py install for mozrunner 15:32:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Running setup.py install for mozscreenshot 15:32:53 INFO - Running setup.py install for moztest 15:32:53 INFO - Running setup.py install for mozversion 15:32:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:32:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:32:53 INFO - Cleaning up... 15:32:53 INFO - Return code: 0 15:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32: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')]} 15:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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')]} 15:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:53 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 0x7f4d99d16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', '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 15:32:53 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 15:32:53 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 15:32:53 INFO - Using env: {'DISPLAY': ':0', 15:32:53 INFO - 'HOME': '/home/cltbld', 15:32:53 INFO - 'LANG': 'en_US.UTF-8', 15:32:53 INFO - 'LANGUAGE': 'en_US:en', 15:32:53 INFO - 'LOGNAME': 'cltbld', 15:32:53 INFO - 'MAIL': '/var/mail/cltbld', 15:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:53 INFO - 'MOZ_NO_REMOTE': '1', 15:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:53 INFO - 'NO_EM_RESTART': '1', 15:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:53 INFO - 'PWD': '/builds/slave/test', 15:32:53 INFO - 'SHELL': '/bin/bash', 15:32:53 INFO - 'SHLVL': '1', 15:32:53 INFO - 'TERM': 'linux', 15:32:53 INFO - 'TMOUT': '86400', 15:32:53 INFO - 'USER': 'cltbld', 15:32:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:54 INFO - '_': '/tools/buildbot/bin/python'} 15:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:54 INFO - Running setup.py (path:/tmp/pip-eTL9It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:54 INFO - Running setup.py (path:/tmp/pip-WgA6zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:54 INFO - Running setup.py (path:/tmp/pip-jmUpIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:54 INFO - Running setup.py (path:/tmp/pip-U1lPS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:54 INFO - Running setup.py (path:/tmp/pip-DqZx7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:54 INFO - Running setup.py (path:/tmp/pip-nbAabR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:54 INFO - Running setup.py (path:/tmp/pip-eelzJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:54 INFO - Running setup.py (path:/tmp/pip-wXKaL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:54 INFO - Running setup.py (path:/tmp/pip-gTZ_d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:54 INFO - Running setup.py (path:/tmp/pip-Cqo7B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:54 INFO - Running setup.py (path:/tmp/pip-P_ngtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:55 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)) 15:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:55 INFO - Running setup.py (path:/tmp/pip-pZW6sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:55 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)) 15:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:55 INFO - Running setup.py (path:/tmp/pip-DkpXRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:55 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)) 15:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:55 INFO - Running setup.py (path:/tmp/pip-jIEl1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:55 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)) 15:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:55 INFO - Running setup.py (path:/tmp/pip-n3DcZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:55 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)) 15:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:55 INFO - Running setup.py (path:/tmp/pip-1Agy6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:55 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)) 15:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:55 INFO - Running setup.py (path:/tmp/pip-lj4458-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:57 INFO - Downloading blessings-1.6.tar.gz 15:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:32:57 INFO - Installing collected packages: blessings 15:32:57 INFO - Running setup.py install for blessings 15:32:57 INFO - Successfully installed blessings 15:32:57 INFO - Cleaning up... 15:32:57 INFO - Return code: 0 15:32:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:32:57 INFO - Reading from file tmpfile_stdout 15:32:57 INFO - Current package versions: 15:32:57 INFO - argparse == 1.2.1 15:32:57 INFO - blessings == 1.6 15:32:57 INFO - blobuploader == 1.2.4 15:32:57 INFO - docopt == 0.6.1 15:32:57 INFO - manifestparser == 1.1 15:32:57 INFO - mozInstall == 1.12 15:32:57 INFO - mozcrash == 0.17 15:32:57 INFO - mozdebug == 0.1 15:32:57 INFO - mozdevice == 0.48 15:32:57 INFO - mozfile == 1.2 15:32:57 INFO - mozhttpd == 0.7 15:32:57 INFO - mozinfo == 0.9 15:32:57 INFO - mozleak == 0.1 15:32:57 INFO - mozlog == 3.1 15:32:57 INFO - moznetwork == 0.27 15:32:57 INFO - mozprocess == 0.22 15:32:57 INFO - mozprofile == 0.28 15:32:57 INFO - mozrunner == 6.11 15:32:57 INFO - mozscreenshot == 0.1 15:32:57 INFO - mozsystemmonitor == 0.0 15:32:57 INFO - moztest == 0.7 15:32:57 INFO - mozversion == 1.4 15:32:57 INFO - psutil == 3.1.1 15:32:57 INFO - requests == 1.2.3 15:32:57 INFO - wsgiref == 0.1.2 15:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:57 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')]} 15:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 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')]} 15:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 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 0x7f4d99d16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', '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 15:32:57 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 15:32:57 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 15:32:57 INFO - Using env: {'DISPLAY': ':0', 15:32:57 INFO - 'HOME': '/home/cltbld', 15:32:57 INFO - 'LANG': 'en_US.UTF-8', 15:32:57 INFO - 'LANGUAGE': 'en_US:en', 15:32:57 INFO - 'LOGNAME': 'cltbld', 15:32:57 INFO - 'MAIL': '/var/mail/cltbld', 15:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:57 INFO - 'MOZ_NO_REMOTE': '1', 15:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:57 INFO - 'NO_EM_RESTART': '1', 15:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:57 INFO - 'PWD': '/builds/slave/test', 15:32:57 INFO - 'SHELL': '/bin/bash', 15:32:57 INFO - 'SHLVL': '1', 15:32:57 INFO - 'TERM': 'linux', 15:32:57 INFO - 'TMOUT': '86400', 15:32:57 INFO - 'USER': 'cltbld', 15:32:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:57 INFO - '_': '/tools/buildbot/bin/python'} 15:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:57 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)) 15:32:57 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)) 15:32:57 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)) 15:32:57 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)) 15:32:57 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)) 15:32:57 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)) 15:32:57 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)) 15:32:57 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)) 15:32:57 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)) 15:32:57 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)) 15:32:57 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)) 15:32:57 INFO - Cleaning up... 15:32:57 INFO - Return code: 0 15:32:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:32:57 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')]} 15:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 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')]} 15:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 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 0x7f4d99d16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', '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 15:32:57 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 15:32:57 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 15:32:57 INFO - Using env: {'DISPLAY': ':0', 15:32:57 INFO - 'HOME': '/home/cltbld', 15:32:57 INFO - 'LANG': 'en_US.UTF-8', 15:32:57 INFO - 'LANGUAGE': 'en_US:en', 15:32:57 INFO - 'LOGNAME': 'cltbld', 15:32:57 INFO - 'MAIL': '/var/mail/cltbld', 15:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:57 INFO - 'MOZ_NO_REMOTE': '1', 15:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:57 INFO - 'NO_EM_RESTART': '1', 15:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:57 INFO - 'PWD': '/builds/slave/test', 15:32:57 INFO - 'SHELL': '/bin/bash', 15:32:57 INFO - 'SHLVL': '1', 15:32:57 INFO - 'TERM': 'linux', 15:32:57 INFO - 'TMOUT': '86400', 15:32:57 INFO - 'USER': 'cltbld', 15:32:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:57 INFO - '_': '/tools/buildbot/bin/python'} 15:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:58 INFO - Downloading/unpacking jsonschema 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:33:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:00 INFO - Downloading/unpacking functools32 (from jsonschema) 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:00 INFO - warning: no files found matching '*.txt' 15:33:00 INFO - no previously-included directories found matching 'build' 15:33:00 INFO - no previously-included directories found matching 'dist' 15:33:00 INFO - no previously-included directories found matching '.git*' 15:33:00 INFO - Installing collected packages: jsonschema, functools32 15:33:00 INFO - Running setup.py install for functools32 15:33:00 INFO - warning: no files found matching '*.txt' 15:33:00 INFO - no previously-included directories found matching 'build' 15:33:00 INFO - no previously-included directories found matching 'dist' 15:33:00 INFO - no previously-included directories found matching '.git*' 15:33:00 INFO - Successfully installed jsonschema functools32 15:33:00 INFO - Cleaning up... 15:33:00 INFO - Return code: 0 15:33:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:33:00 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')]} 15:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:00 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')]} 15:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:00 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 0x7f4d99d16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', '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 15:33:00 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 15:33:00 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 15:33:00 INFO - Using env: {'DISPLAY': ':0', 15:33:00 INFO - 'HOME': '/home/cltbld', 15:33:00 INFO - 'LANG': 'en_US.UTF-8', 15:33:00 INFO - 'LANGUAGE': 'en_US:en', 15:33:00 INFO - 'LOGNAME': 'cltbld', 15:33:00 INFO - 'MAIL': '/var/mail/cltbld', 15:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:00 INFO - 'MOZ_NO_REMOTE': '1', 15:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:00 INFO - 'NO_EM_RESTART': '1', 15:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:00 INFO - 'PWD': '/builds/slave/test', 15:33:00 INFO - 'SHELL': '/bin/bash', 15:33:00 INFO - 'SHLVL': '1', 15:33:00 INFO - 'TERM': 'linux', 15:33:00 INFO - 'TMOUT': '86400', 15:33:00 INFO - 'USER': 'cltbld', 15:33:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:00 INFO - '_': '/tools/buildbot/bin/python'} 15:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:00 INFO - Downloading/unpacking flake8 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:33:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:33:02 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 15:33:02 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 15:33:02 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 15:33:02 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 15:33:02 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 15:33:02 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 15:33:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:33:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:33:02 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 15:33:02 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 15:33:02 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 15:33:02 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 15:33:02 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 15:33:02 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 15:33:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33: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 15:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:33:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:33:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:33:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:33:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:33:03 INFO - no previously-included directories found matching 'docs/_build' 15:33:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:33:03 INFO - Running setup.py install for pep8 15:33:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:33:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:33:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:33:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:33:03 INFO - no previously-included directories found matching 'docs/_build' 15:33:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:33:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:33:03 INFO - Cleaning up... 15:33:03 INFO - Return code: 0 15:33:03 INFO - Running post-action listener: _resource_record_post_action 15:33:03 INFO - Running post-action listener: _start_resource_monitoring 15:33:03 INFO - Starting resource monitoring. 15:33:03 INFO - ##### 15:33:03 INFO - ##### Running install step. 15:33:03 INFO - ##### 15:33:03 INFO - Running pre-action listener: _resource_record_pre_action 15:33:03 INFO - Running main action method: install 15:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:03 INFO - Reading from file tmpfile_stdout 15:33:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:33:03 INFO - Reading from file tmpfile_stdout 15:33:03 INFO - Output received: 15:33:03 INFO - Usage: mozinstall [options] installer 15:33:03 INFO - Options: 15:33:03 INFO - -h, --help show this help message and exit 15:33:03 INFO - -d DEST, --destination=DEST 15:33:03 INFO - Directory to install application into. [default: 15:33:03 INFO - "/builds/slave/test"] 15:33:03 INFO - --app=APP Application being installed. [default: firefox] 15:33:03 INFO - mkdir: /builds/slave/test/build/application 15:33:03 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'] 15:33:03 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 15:33:19 INFO - Reading from file tmpfile_stdout 15:33:19 INFO - Output received: 15:33:19 INFO - /builds/slave/test/build/application/firefox/firefox 15:33:19 INFO - Running post-action listener: _resource_record_post_action 15:33:19 INFO - ##### 15:33:19 INFO - ##### Running run-tests step. 15:33:19 INFO - ##### 15:33:19 INFO - Running pre-action listener: _resource_record_pre_action 15:33:19 INFO - Running main action method: run_tests 15:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:33:19 INFO - Python 2.7.3 15:33:19 INFO - Return code: 0 15:33:19 INFO - grabbing minidump binary from tooltool 15:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:19 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 0x105c410>, '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 0x105d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:33:19 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 15:33:19 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 15:33:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:19 INFO - Return code: 0 15:33:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:33:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:33:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:33:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:33:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:33:20 INFO - Return code: 0 15:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:33:20 INFO - Using env: {'DISPLAY': ':0', 15:33:20 INFO - 'HOME': '/home/cltbld', 15:33:20 INFO - 'LANG': 'en_US.UTF-8', 15:33:20 INFO - 'LANGUAGE': 'en_US:en', 15:33:20 INFO - 'LOGNAME': 'cltbld', 15:33:20 INFO - 'MAIL': '/var/mail/cltbld', 15:33:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:33:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:20 INFO - 'MOZ_NO_REMOTE': '1', 15:33:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:20 INFO - 'NO_EM_RESTART': '1', 15:33:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:20 INFO - 'PWD': '/builds/slave/test', 15:33:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:33:20 INFO - 'SHELL': '/bin/bash', 15:33:20 INFO - 'SHLVL': '1', 15:33:20 INFO - 'TERM': 'linux', 15:33:20 INFO - 'TMOUT': '86400', 15:33:20 INFO - 'USER': 'cltbld', 15:33:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552', 15:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:20 INFO - '_': '/tools/buildbot/bin/python'} 15:33:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:33:20 INFO - mozversion application_buildid: 20160420141806 15:33:20 INFO - mozversion application_changeset: 4feb4dd910a5a2d3061dbdd376a80975206819c6 15:33:20 INFO - mozversion application_display_name: Nightly 15:33:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:20 INFO - mozversion application_name: Firefox 15:33:20 INFO - mozversion application_remotingname: firefox 15:33:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:33:20 INFO - mozversion application_vendor: Mozilla 15:33:20 INFO - mozversion application_version: 48.0a1 15:33:20 INFO - mozversion platform_buildid: 20160420141806 15:33:20 INFO - mozversion platform_changeset: 4feb4dd910a5a2d3061dbdd376a80975206819c6 15:33:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:33:20 INFO - mozversion platform_version: 48.0a1 15:33:20 INFO - using testdate: 1461191600 15:33:20 INFO - actual date: 1461191600 15:33:20 INFO - starting webserver on 'localhost:48282' 15:33:20 INFO - SUITE-START | Running 2 tests 15:33:20 INFO - TEST-START | dromaeo_css 15:33:20 INFO - operating with platform_type : linux_ 15:33:20 INFO - Initialising browser for dromaeo_css test... 15:33:20 INFO - TEST-INFO | started process 30826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpInMmiO/profile http://localhost:48282/getInfo.html) 15:33:25 INFO - PROCESS | 30826 | __metrics Screen width/height:1600/1200 15:33:25 INFO - PROCESS | 30826 | colorDepth:24 15:33:25 INFO - PROCESS | 30826 | Browser inner width/height: 1024/697 15:33:25 INFO - PROCESS | 30826 | __metrics 15:33:26 ERROR - PROCESS | 30826 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:33:27 INFO - TEST-INFO | 30826: exit 0 15:33:27 INFO - Browser initialized. 15:33:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:33:27 INFO - TEST-INFO | started process 30907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpInMmiO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:39 INFO - PROCESS | 30907 | RSS: Main: 155623424 15:33:39 INFO - PROCESS | 30907 | 15:34:30 INFO - PROCESS | 30907 | 1461191670531 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] 15:36:41 INFO - PROCESS | 30907 | Cycle 1(1): loaded http://localhost:48282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48282/tests/dromaeo/cssquery-ext.html) 15:36:42 INFO - PROCESS | 30907 | RSS: Main: 230473728 15:36:42 INFO - PROCESS | 30907 | 15:39:45 INFO - PROCESS | 30907 | Cycle 1(1): loaded http://localhost:48282/tests/dromaeo/cssquery-ext.html (next: http://localhost:48282/tests/dromaeo/cssquery-jquery.html) 15:39:45 INFO - PROCESS | 30907 | RSS: Main: 228364288 15:39:45 INFO - PROCESS | 30907 | 15:42:47 INFO - PROCESS | 30907 | Cycle 1(1): loaded http://localhost:48282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48282/tests/dromaeo/cssquery-mootools.html) 15:42:48 INFO - PROCESS | 30907 | RSS: Main: 229859328 15:42:48 INFO - PROCESS | 30907 | 15:45:50 INFO - PROCESS | 30907 | Cycle 1(1): loaded http://localhost:48282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48282/tests/dromaeo/cssquery-prototype.html) 15:45:51 INFO - PROCESS | 30907 | RSS: Main: 231620608 15:45:51 INFO - PROCESS | 30907 | 15:48:54 INFO - PROCESS | 30907 | Cycle 1(1): loaded http://localhost:48282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48282/tests/dromaeo/cssquery-yui.html) 15:48:54 INFO - PROCESS | 30907 | RSS: Main: 210620416 15:48:54 INFO - PROCESS | 30907 | 15:51:57 INFO - PROCESS | 30907 | Cycle 1(1): loaded http://localhost:48282/tests/dromaeo/cssquery-yui.html (next: http://localhost:48282/tests/dromaeo/cssquery-dojo.html) 15:51:57 INFO - PROCESS | 30907 | RSS: Main: 313008128 15:51:57 INFO - PROCESS | 30907 | 15:51:57 INFO - PROCESS | 30907 | __start_tp_report 15:51:57 INFO - PROCESS | 30907 | _x_x_mozilla_page_load 15:51:57 INFO - PROCESS | 30907 | _x_x_mozilla_page_load_details 15:51:57 INFO - PROCESS | 30907 | |i|pagename|runs| 15:51:57 INFO - PROCESS | 30907 | |0;dojo.html;2573.3695244665055;2617.62044503547;2632.9341766455823;2635.2621266045503;2648.655674762281;4446.599806017458;4517.390152329434;4541.114482675879;4566.543345665436;4574.908501829961;4628.421447319085;4653.255479123341;4658.1149581579475;4692.976535117328;4701.153792317382;4200.600942910419;4218.282891908368;4248.702590818644;4275.657947364219;4353.891152721191;4247.299195632717;4312.82748690052;4321.438213032301;4321.54623764505;4368.322909948963;4168.166366726652;4203.6637069034405;4205.222033923734;4254;4260.55264197261;4261.637760790337;4293.785310734451;4294.141171765628;4294.677899157545;4345;4239.745615263063;4247.681423893189;4261.062566235423;4281.507626622916;4290.206311832321;4374.693771436001;4467.061916997434;4499.415076040126;4542.704724192917;4562.520935301779;4902.65681402302;4906.730129842857;4917.139500587383;4924.335214745999;4946.431160416562;4773.474917759044;4941.036497882914;4948.307236986825;4952.925918959319;4953.95966846959;4590.540945905416;4623.86128416148;4624.098300831306;4662.603678687349;4669.649776266793;4948.802047918115;4972.676776009548;4975.975120124449;4976.776045077981;5020.146575082244;4693.788779504862;4781.593564546983;4783.689060211075;4784.665073444826;4791.760411979387;4943.357363542788;4960.826371076995;4998.800047998112;5008.348914641147;5035.647504674711;4903.975480122576;4909.582685471703;4930.383702037246;4939.777710003059;4967.875803104951;4739.075880203327;4836.347093142451;4899.559039686445;4916.434610019822;4957.7769000395065;4139.648129908992;4151.1075118848985;4163.063310755056;4181.289180839264;4201.789910504463;3620.873269435557;3634.2913131939017;3640.12636967126;3670.908227294339;3696.6488183622514;4084.6732261419015;4164.562720914321;4234.280172370704;4240.215560121387;4257.531671516131;4948.109340318705;4948.653594248368;4958.082754690394;4973.079980203674;5007.499250075036;4230.85192018284;4236.788160591958;4243.7029407941145;4245.448091748053;4290.334998075304;4315.6763242756915;4402.273624851863;4426.15902978433;4429.601335879722;4468.106378724203;4676.134915040729;4713.2458806590785;4716.622670186445;4730.763461826895;4769.618430525619;4941.629377796751;4952.925706114339;4954.207326827835;4965.851024469272;5012.674176178537;4532.546745325441;4662.53374662531;4699.459562150259;4705.905881882411;4757.45289291722;4800.927986080142;4823.300621409806;4832.130216561053;4865.124277629919;4878.195097808822;4862.610991120772;4884.731339776346;4891.584215341593;4893.339399181207;4949.208126699711;4643.883902902455;4742.952570474251;4785.545373189541;4792.472827988849;4813.326134341125;4776.355192049168;4787.210110331756;4798.016406636701;4799.184138696361;4840.29815676732;4683.437987441393;4700.60044896174;4715.575598196042;4721.858344249678;4765.356676848581;4682.695624784378;4824.541668541483;4860.246661767432;4905.730184839868;4910.2880082388565;4709.764511774466;4716.952830471789;4723.220668589644;4731.6214702823;4776.23580227162 15:51:57 INFO - PROCESS | 30907 | |1;ext.html;565.7202537521275;574.4600075928628;593.4125216036124;602.2862907454669;602.8553147244662;33425;34468.1382965426;34495.65504344959;34518.82740586297;34540.481892771626;36559.4516082259;37097.81451092748;37262.25475490488;37266.627333726654;37276.62723372765;7522.285382888617;7682.654280557361;7696.576688282143;7697.307242348187;7701.383889288872;7513.323800857922;7600.5439673619485;7614;7614.162442131361;7617.428692848031;7807.945927299827;7874.724384646539;7877.9212207878045;7879.724209652663;7881.527108373516;7745.806354841117;7801.0638723352995;7804.024496937883;7805.9609701951695;7807.180246074194;7684.961575192144;7796.922030779676;7799.844003119906;7802.102758182825;7803.3367163791145;38364;38795.41806872899;38885.22229555393;38965.61034389676;38982.220355592726;3225.161458020908;3252.0243926822095;3297.934041319184;3425.811580363079;3613.4579813027995;28376.574351384745;28810.567841482396;29094.27264318409;29784.553231701542;29824.25439364033;3401.3537427888623;3498.702610278129;3522.5772907251294;3538.0800991742076;3572.8034958077296;163413;164302;165331;165341;166011;47675.5232447678;48094.5190548097;48507.514924851006;48571.5142848574;48583.27125093126;57797.42202578005;59182.40817591855;59533.404665953654;59540.40459595435;59543.70228148832;13550.661233469242;13669.111507751964;13737.725245495034;13743.244121573409;13751;9888.950555247322;10230.948845255725;10258.538365773558;10262.127719143808;10747.78504429907;17546.034968076878;17617.150199229152;17701;17722.822771772375;17767.20047597861;6974.4420446364165;6982.546134501241;7097.615964886901;7116.359527642537;7178.066851309296;889.6041261638638;935.4340623922565;971.2521358553875;1002.2533212756543;1020.4081632653043;27024.324391889968;28359.71640283612;28499.430011399654;28506;28513.572296415572;920.033964337443;978.0610613810679;987.8320685483485;999.1756800639502;1007.8941711120374;14720.043197192148;14991.32539035746;15090.698186036438;15276.312565934559;15387.384504619913;356253;361654;363904;364664;365528;47655.28517072247;48271.5172848267;48317.75841120772;48528.27207591889;48538.27192592114;1130.6947124276398;1224.375568460074;1247.3700781105665;1254.5797157952006;1263.1789336931067;24440.14459493909;25501.61747573825;25811.483770324863;26056.609150863133;26064.087756928417;35894.231105733525;36265.81867090753;36396.27207455783;36462.27075458529;36501.26997460089;232705;234145;234611;234618;235376;22195.889020555438;22931.656025159304;24651.137210197558;25316.113936012152;25508.617370739827;35706.28587428289;35881.46177807283;35949.64050359568;36687.78090519625;37058.444123337635;31518;31687.683123168474;34135.487967680005;34257.97226083221;34282.65717342795;33340.83329583336;33719;33797.32405351928;34102.31795364029;34178.65821341755;33472.16319592029;33533;33782.324353513286;34144.48783268203;34271.828640856635;29724.872663006725;30665.386692266475;30699.846500768246;30740.692593074677;30816.84591577028;23745.762542374356;24208;24229.114200162214;24529.632055518825;24548.631770523814 15:51:57 INFO - PROCESS | 30907 | |2;jquery.html;366.46862050027465;369.9038250054987;375.09227669040916;375.41435360837096;383.4650662326057;15643.687126257482;16319.83680163198;16820.24308906099;16838.326466941322;16844.073575953316;15281.617959551017;16191.271392787323;17042.14789260535;17125.486235412925;17153.57116072099;5092.872678183047;5273.419923808378;5295.0733621616255;5308.46915308468;5311.760970756306;3666.0834791302173;3841.6926645868402;5167.819126330579;5628.549716022709;5925.229720136376;5854.29748430189;5870.853228669296;5893.145493903381;5898.203742494751;5900.763969441217;5687.232223649796;5810.33181184165;5893.469587737124;5894.115882617599;5908.67502287374;3343.9665603343897;4925.630577706686;5165.509276618715;5170.327857378555;5171.715555644438;18818.62362752751;19045.809541904542;19124.61750764991;20660.5867882643;20663.896680516653;1928.9872816771167;1938.1665883670016;1938.4669215965582;2297.5864344417996;2544.5292620865016;12670.873291267153;12773.808392874114;12866.163699359511;13065.281409522473;13504.189748615016;1783.3223375117502;1862.3481781376545;1873.7095750158746;1888.4334699590206;1925.422373288008;64916.67541662262;64968.350316496704;66060;66982.95730076426;67052.3294767051;9313.953430232805;9509.90490095104;9760.121589057018;10218.846717299246;10237.692869213935;13188.208707477583;13243.404046817916;13287.800682989762;13293.069485135948;13335.199888006751;6923.2038315593345;6991.685374158175;7008.088948436671;7038.964805176044;7055.823604409931;6527.510436717265;6536.509761767887;6540.247871494744;6807.149106361705;7029.89455158173;5821.94178058214;5999.910001349983;6053.4854537363935;6083.969580152159;6128.387161283836;1576.7950166478513;1636.8936019158716;1644.5313085770738;1715.1852869886704;1737.3311275159156;869.699953516036;902.7472307753708;904.263025634106;916.3814425262921;946.8295706772847;15672.138032408327;15993.840061599467;16274.349026039063;16392.83607163937;16800.15999200035;876.7545087375545;909.9785391771513;918.3571499949928;954.9713508594754;963.6627180486773;9195.126462986005;9679.370840895319;9707.514624268759;9733.659321923698;9853.704388868346;399866;413234;420125;422685;426907;67028.32971670319;67129;68329.3167068323;68552.6572367135;69104.96342554866;981.1513041219293;985.9063388978036;1012.3217444312328;1018.9286749927434;1030.3508789462592;14288.785668215192;14368.784468233194;14396.136231826124;14534.636634084232;14736.26318684083;30569.23576910595;31115;31138;31345.373092538477;31593.8420307897;39007;40653.390199146445;40667.59332406638;41704.58295417128;41714.165716686104;7610.695572177051;7613.314801667876;7613.809654758454;7633.313001829862;7679.424043196671;11427.428628568372;11701.180917335705;11702.239354441934;11716.23844450108;11985.460654270404;10182.731342246667;10200.744981375525;10261.58953641846;10390.116840068678;10456.581736730446;9947;10154.289199756242;10176.796464070825;10412.21908356861;10442.895571044191;10177.898221017695;10420.32267902584;10722.73193170177;10743.785124297627;10858.945705271422;7439.628018599156;7496.850062998818;7543.622818858926;7616.0860696716745;7619.847603048019;9638.180754635654;10273.9486302568;10344.120749736358;10424.218183636409;10502.264841461025 15:51:57 INFO - PROCESS | 30907 | |3;mootools.html;1183.2131632464411;1432.5559076686227;1472.8895332850038;1604.8234694183639;1790.1228398084943;6827.31726827317;7434.739784107557;7667.84664306715;7682.423818213629;7694.576798276093;7382.409407247421;7504.737334193304;7541;7551.093868735746;7553.735619253327;1945.6984167454068;2190.7042549255884;2229.1529218896835;2254.199759085526;2258.8418810683174;2279.7720227977234;2299.6435552489306;2301.022065622104;2301.8849057547054;2308.699869017034;2231.419830843976;2267.2744721689064;2268.5576312619046;2272.556851413975;2273.545290941818;1889.4426144287468;2172.4568857785475;2238.373255488466;2239.596872562938;2241.1371621925678;2143.3677065265783;2154.1275783307788;2162.1459523488134;2166.480044789255;2175.3908905506482;7585.317321441042;7590.506617069928;7631.1605723370385;7650.043744531934;7650.808729781745;4414.9337759933305;4574.794134263932;4584.633229341644;4589.954100458986;4592.816287348502;2948.6609039960463;2968.4359971605327;3015.909522714322;3060.265536271279;3061.4642437573334;966.6520052780993;1678.8489035986697;1791.7312403139504;1859.2748827957107;1891.9905400473046;9840.11438970496;10005.749856253578;10015.899841001643;10073.043060909202;10080.445575493344;3976.204759048202;4016.8995775105273;4177.436046133794;4180.749155050707;4243.596858298457;8099.635516401776;8099.757007289791;8129.227723366271;8167.509949403055;8305.792355191168;3951.644352008333;4506.459224893034;4510.639148868148;4514.774261286922;4520.547945205453;4028.657564107025;4088.4684990950987;4095.24238015968;4109.938350924738;4126.834926602963;3453.9481907771406;3543.0965103898343;3569.714422846166;3628.7097032237884;3674.2651469706166;1067.8611780468489;1091.1925175370327;1092.464692300767;1101.6750058732694;1110.1784679337231;710.5488015110442;768.8885111658778;806.467731297341;853.4665833853842;878.8974918537446;5276.577873770089;5432.212329212242;5544.91682624761;5567.24842146305;5605.691686957257;875.5490922175085;895.5119459894373;931.0689310689311;931.0689310689311;951.1012093571509;3666.1934374437583;3822.57951625321;3932.567417584121;3964.0684439156776;3974.3442332014893;9150.359474836698;9550.856737148948;9633.759156021015;9645.807083858424;9682.515874206403;9310.068993100636;9418.387804792666;9438.95280523593;9503.239740820718;9514.714558563253;7205.783826485109;7207.675654595451;7224.891626625605;7300.4159667226495;7335.77992660221;5339.786408543615;5384.6769193848495;5489.725513724377;5504.009278329939;5559.749811258584;8388.245057944814;8573.74278771638;8627.87058194115;8682.869756953776;8752.387332886638;8413.411061225655;8548.529830859114;8793.868091978753;8907.10928907104;8917.777055573402;6615.702293396713;6939.271376505394;6990.510664253454;7065.364117229474;7220.241874603301;7369.078865141857;7400.629968501446;7469.701211951461;7470.439717021137;7475.7009719610605;6549.4760419167305;6696.464282857262;6755.392014718699;6848.7260509579055;6862.553933994274;6654.600723956578;6689.966550167218;6724.831879203059;6766.4248538874745;6797.1163748714325;6353.174087368612;6498.862699027746;6567.671616419256;6568.146141001639;6572.671366431755;4739.668223224479;4757.500462451531;4912.754362281943;4940.530649588283;4947.356843610308;4729.976350118227;4752;4830.396200474941;4926.187179115406;4968.677035992649 15:51:57 INFO - PROCESS | 30907 | |4;prototype.html;307.19361675601544;308.1372157957719;308.7005604563573;312.36433857100803;314.21603100264815;5006.899862002758;5058.342415485991;5063.670861394012;5064.924026139611;5077.512019110637;4985.351904252451;4992.350994370736;5015.9749201254035;5017.9498205017935;5029.823956161535;3752.8123593820337;3819.3698039823394;3927.1163988102735;3929.4105884117466;3986.4618276532733;3932.154586763845;3967.61133603238;3969.702272329572;3976.2643910876436;3987.1029018470904;3698.389765688658;3933.5476420211758;3940.152867133566;3947.8223479943326;3953.960460395388;3804.144067584799;3926.3128952433494;3943.8225279862477;3948.348522493814;3949.545802232737;3456.2741824216946;3482.355764183634;3486.7733597316346;3488.6511348865165;3506.6843984041557;4825.155597770411;4833.226683730586;4835.202191638376;4840.540148685869;4856.198727210006;4147.81334839933;4352.086061926968;4361.738295702268;4368.170047690928;4507.346434766973;5234.81678141267;5242.689327668083;5247.763850626731;5257.447967963385;5257.947420525784;3612.440071788877;3614.765040272374;3614.8554057837655;3621.022323972513;3623.1304486923214;5292.735363231823;5394.91907621386;5460.918086228709;5525.364583072957;5564.8330550083565;3792.393217085308;3808.447775072654;3810.1998580297895;3812;3815.503984482055;3857.787821669835;3859.9035024124623;3861.942070868939;3868.0909986153233;3875.9806200968815;4300.956990430118;4423.093265880487;4429.734215946989;4432.135733531994;4436.3123715824095;5216.530512253916;5284.682919024871;5287.788488460418;5318.12250978592;5324.8136315228785;1313.2055106660332;1339.3771896068374;1340.3097404836517;1342.2215115233141;1343.1068339554283;832.9416940814206;877.0922095631119;893.4505279253212;903.7921278106072;913.3423934766957;4628.449469427712;4630.3748993886065;4633.675642704979;4638.257878739453;4645.488996210414;5397.433269506724;5410.458954104637;5419.756110975016;5439.673619582838;5455.1271796512365;4451.154280686659;4603.5396460353695;4613.8846528836375;4616.746078965622;4630.0739852029055;2884.956725649117;2886.975123831052;2898.3478717288863;2902.3179552805072;2905.912822615325;5136.101182293084;5138.794448222029;5143.562797162208;5151.896962060738;5160.8967820643375;5322.893542129135;5511.145772405283;5516.117421212587;5651.463111004448;5654.321481422174;5204.193350030676;5210.244514545446;5227.790888364423;5230.3985041719925;5232.162853943427;5534.7786088556;5547.33431988164;5549.667019978814;5557.583181261502;5565.7217139143695;5201.075602027274;5379.19312103172;5380.811671591476;5382.165764306539;5403.756830942696;5163.638545301793;5189.636725429335;5195.090859099718;5216.452272511332;5226.398964119175;3805.733598648179;3807.1814559869763;3807.2004878975727;3808.485854409619;3822.3310920589342;5296.920546191733;5395.190721391823;5431.728413579226;5434.3207099112615;5437.564994800486;5261.105612045885;5280.6303558750515;5288.286081378965;5312.4156342803035;5325.627206095536;5135.614828887774;5303.15149576066;5305.442928492453;5318.494742999409;5333.386660534088;5222.216667499905;5229.398619158846;5241.711705856214;5263.131583288715;5275.525202731773;5078.238264260242;5154.278401023935;5292.941411717748;5354.705491198021;5380.946190538045;5231.267622532924;5245.580353571629;5251.474852514718;5255.763490643007;5283.286756287852 15:51:57 INFO - PROCESS | 30907 | |5;yui.html;634.7238951056289;675.6722989350168;685.1743648903072;727.5561907236585;782.647808486181;12179.147459677826;12271.263724176533;12275.938620306897;12291.262524248552;12293.754124917508;11876.703082422944;11915.582954596592;11931.58239461619;11947.044236461084;12962.222266664006;804.6057431858405;811.0672726364669;812.6789917982394;812.8049268175654;812.8496228197773;633.531186921677;788.9368850491976;797.0873350014231;803.3613277444446;808.4260175275532;841.8905542279496;843.87763774253;844.2275318083946;846.1665259719172;847.5846835050811;828.6892415344246;828.9709860154866;829.9128591497927;831.2186544648011;837.5142417397925;486.7858142417325;593.9605690042425;601.9006863867456;602.5842168903487;616.3251239892355;13069.673258168526;13098;13133.934330328382;13148.40832162555;13196.340182990909;12426.875731242662;12959.87040129596;13236.272005039718;13241.856592258711;13299.202047877061;10083;10096.848547271797;10163.4918254087;10317.226208034352;10471;3342.2814094969453;3398.3033478137168;3398.4222682144095;3422.8117453540044;3472.409690352646;46392.536074639494;46416.303755443696;46928;46978;47080.7645961768;10251.231157663206;10261.692149235534;10381.11760500366;10656.62701805433;10811.567537298577;18604.534886627673;18631.720524192147;18653.160607772683;18731.063446827604;18791;6809.148856392951;6943.479239057091;7054.294570542905;7058.647067646597;7100.92899071013;3885.1841113365945;3903.980480097581;3924.7841368724994;3977.900552486211;4049.5140583130215;2836.290927268183;2867.9283017924304;2899.536074228113;2900.2024443277846;2900.5939168516425;489.11714355587793;489.87263311539255;496.87329730918384;501.4609295007881;502.52260352665115;607.7417097733446;626.8338890194102;633.4773811605444;634.4987459906714;636.5599940415565;7615.428842836809;8008.256551394069;8177.914631768861;8235.176482351717;8541.231289184003;584.3221862639318;600.5675913342386;609.5002098279368;628.7862126876884;629.8519847835755;3914.451976723261;3949.881503554898;4081.673466122703;4192.203481338536;4197.181549597799;43159.13681726411;46677.53322466732;46704.76647616808;46784;46840.5315946843;41335.58664413378;41580.59452271186;41647.58352416498;42388.57611423908;43136;31310.68689313123;32432.513512297333;35275;35819.4627080594;36174.81912590473;8232.547209903512;8268;8318.334533237205;8350.582470876554;8475.32197424217;27662.771037142673;27674.308142296602;27913;28008.43983120367;28113.156605301872;33903;34509.654903450646;36185.45721814122;36594.45108323324;36757.816210918776;10051.899481005388;10524.684259472227;10734.516946737573;10917.181211409017;10925.28214680595;11866.347350895783;11868.643940681794;11911.344876031555;11967.461464234304;12204.450799713857;11325;11363.261388009752;11574.18980671345;12031.15781895259;12057.879421205676;11382;11423.885761142283;11875.465604047666;11917.642470725892;12226.816597750863;11085.05777008931;11172.888271117185;11525.711857203636;11943.641690749291;11953;9619.951900240454;9671.274654400808;9855.507224638883;9865.605375784888;10050;9387.81224375495;10005.299629025898;10085.092341689284;10086.8486972694;10122.342047766871 15:51:57 INFO - PROCESS | 30907 | __end_tp_report 15:51:57 INFO - PROCESS | 30907 | __start_cc_report 15:51:57 INFO - PROCESS | 30907 | _x_x_mozilla_cycle_collect,999 15:51:57 INFO - PROCESS | 30907 | __end_cc_report 15:51:57 INFO - PROCESS | 30907 | __startTimestamp1461192717916__endTimestamp 15:51:57 INFO - PROCESS | 30907 | 15:51:57 INFO - PROCESS | 30907 | ------- Summary: start ------- 15:51:57 INFO - PROCESS | 30907 | Number of tests: 6 15:51:57 INFO - PROCESS | 30907 | 15:51:57 INFO - PROCESS | 30907 | [#0] dojo.html Cycles:165 Average:4552.76 Median:4700.60 stddev:467.51 (9.9%) stddev-sans-first:442.40 15:51:57 INFO - PROCESS | 30907 | Values: 2573.4 2617.6 2632.9 2635.3 2648.7 4446.6 4517.4 4541.1 4566.5 4574.9 4628.4 4653.3 4658.1 4693.0 4701.2 4200.6 4218.3 4248.7 4275.7 4353.9 4247.3 4312.8 4321.4 4321.5 4368.3 4168.2 4203.7 4205.2 4254.0 4260.6 4261.6 4293.8 4294.1 4294.7 4345.0 4239.7 4247.7 4261.1 4281.5 4290.2 4374.7 4467.1 4499.4 4542.7 4562.5 4902.7 4906.7 4917.1 4924.3 4946.4 4773.5 4941.0 4948.3 4952.9 4954.0 4590.5 4623.9 4624.1 4662.6 4669.6 4948.8 4972.7 4976.0 4976.8 5020.1 4693.8 4781.6 4783.7 4784.7 4791.8 4943.4 4960.8 4998.8 5008.3 5035.6 4904.0 4909.6 4930.4 4939.8 4967.9 4739.1 4836.3 4899.6 4916.4 4957.8 4139.6 4151.1 4163.1 4181.3 4201.8 3620.9 3634.3 3640.1 3670.9 3696.6 4084.7 4164.6 4234.3 4240.2 4257.5 4948.1 4948.7 4958.1 4973.1 5007.5 4230.9 4236.8 4243.7 4245.4 4290.3 4315.7 4402.3 4426.2 4429.6 4468.1 4676.1 4713.2 4716.6 4730.8 4769.6 4941.6 4952.9 4954.2 4965.9 5012.7 4532.5 4662.5 4699.5 4705.9 4757.5 4800.9 4823.3 4832.1 4865.1 4878.2 4862.6 4884.7 4891.6 4893.3 4949.2 4643.9 4743.0 4785.5 4792.5 4813.3 4776.4 4787.2 4798.0 4799.2 4840.3 4683.4 4700.6 4715.6 4721.9 4765.4 4682.7 4824.5 4860.2 4905.7 4910.3 4709.8 4717.0 4723.2 4731.6 4776.2 15:51:57 INFO - PROCESS | 30907 | 15:51:57 INFO - PROCESS | 30907 | [#1] ext.html Cycles:180 Average:40993.71 Median:34529.65 stddev:70270.91 (203.5%) stddev-sans-first:70402.48 15:51:57 INFO - PROCESS | 30907 | Values: 565.7 574.5 593.4 602.3 602.9 33425.0 34468.1 34495.7 34518.8 34540.5 36559.5 37097.8 37262.3 37266.6 37276.6 7522.3 7682.7 7696.6 7697.3 7701.4 7513.3 7600.5 7614.0 7614.2 7617.4 7807.9 7874.7 7877.9 7879.7 7881.5 7745.8 7801.1 7804.0 7806.0 7807.2 7685.0 7796.9 7799.8 7802.1 7803.3 38364.0 38795.4 38885.2 38965.6 38982.2 3225.2 3252.0 3297.9 3425.8 3613.5 28376.6 28810.6 29094.3 29784.6 29824.3 3401.4 3498.7 3522.6 3538.1 3572.8 163413.0 164302.0 165331.0 165341.0 166011.0 47675.5 48094.5 48507.5 48571.5 48583.3 57797.4 59182.4 59533.4 59540.4 59543.7 13550.7 13669.1 13737.7 13743.2 13751.0 9889.0 10230.9 10258.5 10262.1 10747.8 17546.0 17617.2 17701.0 17722.8 17767.2 6974.4 6982.5 7097.6 7116.4 7178.1 889.6 935.4 971.3 1002.3 1020.4 27024.3 28359.7 28499.4 28506.0 28513.6 920.0 978.1 987.8 999.2 1007.9 14720.0 14991.3 15090.7 15276.3 15387.4 356253.0 361654.0 363904.0 364664.0 365528.0 47655.3 48271.5 48317.8 48528.3 48538.3 1130.7 1224.4 1247.4 1254.6 1263.2 24440.1 25501.6 25811.5 26056.6 26064.1 35894.2 36265.8 36396.3 36462.3 36501.3 232705.0 234145.0 234611.0 234618.0 235376.0 22195.9 22931.7 24651.1 25316.1 25508.6 35706.3 35881.5 35949.6 36687.8 37058.4 31518.0 31687.7 34135.5 34258.0 34282.7 33340.8 33719.0 33797.3 34102.3 34178.7 33472.2 33533.0 33782.3 34144.5 34271.8 29724.9 30665.4 30699.8 30740.7 30816.8 23745.8 24208.0 24229.1 24529.6 24548.6 15:51:57 INFO - PROCESS | 30907 | 15:51:57 INFO - PROCESS | 30907 | [#2] jquery.html Cycles:180 Average:24304.72 Median:21424.35 stddev:68273.54 (318.7%) stddev-sans-first:68441.41 15:51:57 INFO - PROCESS | 30907 | Values: 366.5 369.9 375.1 375.4 383.5 15643.7 16319.8 16820.2 16838.3 16844.1 15281.6 16191.3 17042.1 17125.5 17153.6 5092.9 5273.4 5295.1 5308.5 5311.8 3666.1 3841.7 5167.8 5628.5 5925.2 5854.3 5870.9 5893.1 5898.2 5900.8 5687.2 5810.3 5893.5 5894.1 5908.7 3344.0 4925.6 5165.5 5170.3 5171.7 18818.6 19045.8 19124.6 20660.6 20663.9 1929.0 1938.2 1938.5 2297.6 2544.5 12670.9 12773.8 12866.2 13065.3 13504.2 1783.3 1862.3 1873.7 1888.4 1925.4 64916.7 64968.4 66060.0 66983.0 67052.3 9314.0 9509.9 9760.1 10218.8 10237.7 13188.2 13243.4 13287.8 13293.1 13335.2 6923.2 6991.7 7008.1 7039.0 7055.8 6527.5 6536.5 6540.2 6807.1 7029.9 5821.9 5999.9 6053.5 6084.0 6128.4 1576.8 1636.9 1644.5 1715.2 1737.3 869.7 902.7 904.3 916.4 946.8 15672.1 15993.8 16274.3 16392.8 16800.2 876.8 910.0 918.4 955.0 963.7 9195.1 9679.4 9707.5 9733.7 9853.7 399866.0 413234.0 420125.0 422685.0 426907.0 67028.3 67129.0 68329.3 68552.7 69105.0 981.2 985.9 1012.3 1018.9 1030.4 14288.8 14368.8 14396.1 14534.6 14736.3 30569.2 31115.0 31138.0 31345.4 31593.8 39007.0 40653.4 40667.6 41704.6 41714.2 7610.7 7613.3 7613.8 7633.3 7679.4 11427.4 11701.2 11702.2 11716.2 11985.5 10182.7 10200.7 10261.6 10390.1 10456.6 9947.0 10154.3 10176.8 10412.2 10442.9 10177.9 10420.3 10722.7 10743.8 10858.9 7439.6 7496.9 7543.6 7616.1 7619.8 9638.2 10273.9 10344.1 10424.2 10502.3 15:51:57 INFO - PROCESS | 30907 | 15:51:57 INFO - PROCESS | 30907 | [#3] mootools.html Cycles:180 Average:5109.55 Median:5408.44 stddev:2728.97 (50.5%) stddev-sans-first:2720.66 15:51:57 INFO - PROCESS | 30907 | Values: 1183.2 1432.6 1472.9 1604.8 1790.1 6827.3 7434.7 7667.8 7682.4 7694.6 7382.4 7504.7 7541.0 7551.1 7553.7 1945.7 2190.7 2229.2 2254.2 2258.8 2279.8 2299.6 2301.0 2301.9 2308.7 2231.4 2267.3 2268.6 2272.6 2273.5 1889.4 2172.5 2238.4 2239.6 2241.1 2143.4 2154.1 2162.1 2166.5 2175.4 7585.3 7590.5 7631.2 7650.0 7650.8 4414.9 4574.8 4584.6 4590.0 4592.8 2948.7 2968.4 3015.9 3060.3 3061.5 966.7 1678.8 1791.7 1859.3 1892.0 9840.1 10005.7 10015.9 10073.0 10080.4 3976.2 4016.9 4177.4 4180.7 4243.6 8099.6 8099.8 8129.2 8167.5 8305.8 3951.6 4506.5 4510.6 4514.8 4520.5 4028.7 4088.5 4095.2 4109.9 4126.8 3453.9 3543.1 3569.7 3628.7 3674.3 1067.9 1091.2 1092.5 1101.7 1110.2 710.5 768.9 806.5 853.5 878.9 5276.6 5432.2 5544.9 5567.2 5605.7 875.5 895.5 931.1 931.1 951.1 3666.2 3822.6 3932.6 3964.1 3974.3 9150.4 9550.9 9633.8 9645.8 9682.5 9310.1 9418.4 9439.0 9503.2 9514.7 7205.8 7207.7 7224.9 7300.4 7335.8 5339.8 5384.7 5489.7 5504.0 5559.7 8388.2 8573.7 8627.9 8682.9 8752.4 8413.4 8548.5 8793.9 8907.1 8917.8 6615.7 6939.3 6990.5 7065.4 7220.2 7369.1 7400.6 7469.7 7470.4 7475.7 6549.5 6696.5 6755.4 6848.7 6862.6 6654.6 6690.0 6724.8 6766.4 6797.1 6353.2 6498.9 6567.7 6568.1 6572.7 4739.7 4757.5 4912.8 4940.5 4947.4 4730.0 4752.0 4830.4 4926.2 4968.7 15:51:57 INFO - PROCESS | 30907 | 15:51:57 INFO - PROCESS | 30907 | [#4] prototype.html Cycles:180 Average:4379.64 Median:5044.08 stddev:1284.38 (25.5%) stddev-sans-first:1251.08 15:51:57 INFO - PROCESS | 30907 | Values: 307.2 308.1 308.7 312.4 314.2 5006.9 5058.3 5063.7 5064.9 5077.5 4985.4 4992.4 5016.0 5017.9 5029.8 3752.8 3819.4 3927.1 3929.4 3986.5 3932.2 3967.6 3969.7 3976.3 3987.1 3698.4 3933.5 3940.2 3947.8 3954.0 3804.1 3926.3 3943.8 3948.3 3949.5 3456.3 3482.4 3486.8 3488.7 3506.7 4825.2 4833.2 4835.2 4840.5 4856.2 4147.8 4352.1 4361.7 4368.2 4507.3 5234.8 5242.7 5247.8 5257.4 5257.9 3612.4 3614.8 3614.9 3621.0 3623.1 5292.7 5394.9 5460.9 5525.4 5564.8 3792.4 3808.4 3810.2 3812.0 3815.5 3857.8 3859.9 3861.9 3868.1 3876.0 4301.0 4423.1 4429.7 4432.1 4436.3 5216.5 5284.7 5287.8 5318.1 5324.8 1313.2 1339.4 1340.3 1342.2 1343.1 832.9 877.1 893.5 903.8 913.3 4628.4 4630.4 4633.7 4638.3 4645.5 5397.4 5410.5 5419.8 5439.7 5455.1 4451.2 4603.5 4613.9 4616.7 4630.1 2885.0 2887.0 2898.3 2902.3 2905.9 5136.1 5138.8 5143.6 5151.9 5160.9 5322.9 5511.1 5516.1 5651.5 5654.3 5204.2 5210.2 5227.8 5230.4 5232.2 5534.8 5547.3 5549.7 5557.6 5565.7 5201.1 5379.2 5380.8 5382.2 5403.8 5163.6 5189.6 5195.1 5216.5 5226.4 3805.7 3807.2 3807.2 3808.5 3822.3 5296.9 5395.2 5431.7 5434.3 5437.6 5261.1 5280.6 5288.3 5312.4 5325.6 5135.6 5303.2 5305.4 5318.5 5333.4 5222.2 5229.4 5241.7 5263.1 5275.5 5078.2 5154.3 5292.9 5354.7 5380.9 5231.3 5245.6 5251.5 5255.8 5283.3 15:51:57 INFO - PROCESS | 30907 | 15:51:57 INFO - PROCESS | 30907 | [#5] yui.html Cycles:180 Average:12325.96 Median:3894.58 stddev:13081.47 (335.9%) stddev-sans-first:13088.70 15:51:57 INFO - PROCESS | 30907 | Values: 634.7 675.7 685.2 727.6 782.6 12179.1 12271.3 12275.9 12291.3 12293.8 11876.7 11915.6 11931.6 11947.0 12962.2 804.6 811.1 812.7 812.8 812.8 633.5 788.9 797.1 803.4 808.4 841.9 843.9 844.2 846.2 847.6 828.7 829.0 829.9 831.2 837.5 486.8 594.0 601.9 602.6 616.3 13069.7 13098.0 13133.9 13148.4 13196.3 12426.9 12959.9 13236.3 13241.9 13299.2 10083.0 10096.8 10163.5 10317.2 10471.0 3342.3 3398.3 3398.4 3422.8 3472.4 46392.5 46416.3 46928.0 46978.0 47080.8 10251.2 10261.7 10381.1 10656.6 10811.6 18604.5 18631.7 18653.2 18731.1 18791.0 6809.1 6943.5 7054.3 7058.6 7100.9 3885.2 3904.0 3924.8 3977.9 4049.5 2836.3 2867.9 2899.5 2900.2 2900.6 489.1 489.9 496.9 501.5 502.5 607.7 626.8 633.5 634.5 636.6 7615.4 8008.3 8177.9 8235.2 8541.2 584.3 600.6 609.5 628.8 629.9 3914.5 3949.9 4081.7 4192.2 4197.2 43159.1 46677.5 46704.8 46784.0 46840.5 41335.6 41580.6 41647.6 42388.6 43136.0 31310.7 32432.5 35275.0 35819.5 36174.8 8232.5 8268.0 8318.3 8350.6 8475.3 27662.8 27674.3 27913.0 28008.4 28113.2 33903.0 34509.7 36185.5 36594.5 36757.8 10051.9 10524.7 10734.5 10917.2 10925.3 11866.3 11868.6 11911.3 11967.5 12204.5 11325.0 11363.3 11574.2 12031.2 12057.9 11382.0 11423.9 11875.5 11917.6 12226.8 11085.1 11172.9 11525.7 11943.6 11953.0 9620.0 9671.3 9855.5 9865.6 10050.0 9387.8 10005.3 10085.1 10086.8 10122.3 15:51:57 INFO - PROCESS | 30907 | -------- Summary: end -------- 15:51:57 INFO - PROCESS | 30907 | 15:51:58 INFO - TEST-INFO | 30907: exit 0 15:51:58 INFO - TEST-OK | dromaeo_css | took 1117707ms 15:51:58 INFO - TEST-START | kraken 15:51:58 INFO - operating with platform_type : linux_ 15:51:58 INFO - Initialising browser for kraken test... 15:51:58 INFO - TEST-INFO | started process 31083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOWxXPa/profile http://localhost:48282/getInfo.html) 15:52:02 INFO - PROCESS | 31083 | __metrics Screen width/height:1600/1200 15:52:02 INFO - PROCESS | 31083 | colorDepth:24 15:52:02 INFO - PROCESS | 31083 | Browser inner width/height: 1024/697 15:52:02 INFO - PROCESS | 31083 | __metrics 15:52:03 ERROR - PROCESS | 31083 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:52:04 INFO - TEST-INFO | 31083: exit 0 15:52:04 INFO - Browser initialized. 15:52:04 INFO - Running cycle 1/1 for kraken test... 15:52:04 INFO - TEST-INFO | started process 31162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOWxXPa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:16 INFO - PROCESS | 31162 | RSS: Main: 155262976 15:52:16 INFO - PROCESS | 31162 | 15:52:19 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48282/tests/kraken/driver.html?testName=audio-beat-detection) 15:52:20 INFO - PROCESS | 31162 | RSS: Main: 210026496 15:52:20 INFO - PROCESS | 31162 | 15:52:23 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48282/tests/kraken/driver.html?testName=audio-dft) 15:52:23 INFO - PROCESS | 31162 | RSS: Main: 195395584 15:52:23 INFO - PROCESS | 31162 | 15:52:26 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48282/tests/kraken/driver.html?testName=audio-fft) 15:52:27 INFO - PROCESS | 31162 | RSS: Main: 266080256 15:52:27 INFO - PROCESS | 31162 | 15:52:29 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48282/tests/kraken/driver.html?testName=audio-oscillator) 15:52:30 INFO - PROCESS | 31162 | RSS: Main: 174149632 15:52:30 INFO - PROCESS | 31162 | 15:52:32 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:33 INFO - PROCESS | 31162 | RSS: Main: 178622464 15:52:33 INFO - PROCESS | 31162 | 15:52:36 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48282/tests/kraken/driver.html?testName=imaging-darkroom) 15:52:36 INFO - PROCESS | 31162 | RSS: Main: 215121920 15:52:36 INFO - PROCESS | 31162 | 15:52:40 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48282/tests/kraken/driver.html?testName=imaging-desaturate) 15:52:40 INFO - PROCESS | 31162 | RSS: Main: 212475904 15:52:40 INFO - PROCESS | 31162 | 15:52:43 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48282/tests/kraken/driver.html?testName=json-parse-financial) 15:52:44 INFO - PROCESS | 31162 | RSS: Main: 213782528 15:52:44 INFO - PROCESS | 31162 | 15:52:46 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:52:46 INFO - PROCESS | 31162 | RSS: Main: 200392704 15:52:46 INFO - PROCESS | 31162 | 15:52:48 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48282/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:52:49 INFO - PROCESS | 31162 | RSS: Main: 203579392 15:52:49 INFO - PROCESS | 31162 | 15:52:51 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:52:52 INFO - PROCESS | 31162 | RSS: Main: 218066944 15:52:52 INFO - PROCESS | 31162 | 15:52:54 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:52:55 INFO - PROCESS | 31162 | RSS: Main: 225394688 15:52:55 INFO - PROCESS | 31162 | 15:52:58 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:52:58 INFO - PROCESS | 31162 | RSS: Main: 219840512 15:52:58 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | Cycle 1(1): loaded http://localhost:48282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48282/tests/kraken/driver.html?testName=ai-astar) 15:53:00 INFO - PROCESS | 31162 | RSS: Main: 284139520 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | __start_tp_report 15:53:00 INFO - PROCESS | 31162 | _x_x_mozilla_page_load 15:53:00 INFO - PROCESS | 31162 | _x_x_mozilla_page_load_details 15:53:00 INFO - PROCESS | 31162 | |i|pagename|runs| 15:53:00 INFO - PROCESS | 31162 | |0;ai-astar;112;115;110;112;113;113;103;112;112;114 15:53:00 INFO - PROCESS | 31162 | |1;audio-beat-detection;159;132;161;195;138;169;160;133;185;131 15:53:00 INFO - PROCESS | 31162 | |2;audio-dft;159;161;161;159;161;161;161;162;163;162 15:53:00 INFO - PROCESS | 31162 | |3;audio-fft;74;73;82;111;74;74;73;117;102;73 15:53:00 INFO - PROCESS | 31162 | |4;audio-oscillator;93;94;141;94;94;94;139;94;94;144 15:53:00 INFO - PROCESS | 31162 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;117 15:53:00 INFO - PROCESS | 31162 | |6;imaging-darkroom;147;147;146;147;146;146;147;148;146;146 15:53:00 INFO - PROCESS | 31162 | |7;imaging-desaturate;94;94;95;95;96;95;95;95;95;95 15:53:00 INFO - PROCESS | 31162 | |8;json-parse-financial;64;65;64;64;63;64;66;98;63;63 15:53:00 INFO - PROCESS | 31162 | |9;json-stringify-tinderbox;65;65;65;65;66;65;65;65;66;66 15:53:00 INFO - PROCESS | 31162 | |10;stanford-crypto-aes;79;81;79;78;79;80;80;80;79;79 15:53:00 INFO - PROCESS | 31162 | |11;stanford-crypto-ccm;134;133;135;134;133;131;132;137;179;134 15:53:00 INFO - PROCESS | 31162 | |12;stanford-crypto-pbkdf2;178;175;180;175;174;171;172;171;173;174 15:53:00 INFO - PROCESS | 31162 | |13;stanford-crypto-sha256-iterative;74;73;71;74;76;72;72;71;71;71 15:53:00 INFO - PROCESS | 31162 | __end_tp_report 15:53:00 INFO - PROCESS | 31162 | __start_cc_report 15:53:00 INFO - PROCESS | 31162 | _x_x_mozilla_cycle_collect,1895 15:53:00 INFO - PROCESS | 31162 | __end_cc_report 15:53:00 INFO - PROCESS | 31162 | __startTimestamp1461192780970__endTimestamp 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | ------- Summary: start ------- 15:53:00 INFO - PROCESS | 31162 | Number of tests: 14 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:3.31 (2.9%) stddev-sans-first:3.50 15:53:00 INFO - PROCESS | 31162 | Values: 112.0 115.0 110.0 112.0 113.0 113.0 103.0 112.0 112.0 114.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#1] audio-beat-detection Cycles:10 Average:156.30 Median:160.50 stddev:22.69 (14.1%) stddev-sans-first:24.05 15:53:00 INFO - PROCESS | 31162 | Values: 159.0 132.0 161.0 195.0 138.0 169.0 160.0 133.0 185.0 131.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.09 15:53:00 INFO - PROCESS | 31162 | Values: 159.0 161.0 161.0 159.0 161.0 161.0 161.0 162.0 163.0 162.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#3] audio-fft Cycles:10 Average:85.30 Median:73.50 stddev:17.61 (24.0%) stddev-sans-first:18.20 15:53:00 INFO - PROCESS | 31162 | Values: 74.0 73.0 82.0 111.0 74.0 74.0 73.0 117.0 102.0 73.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:94.00 stddev:22.97 (24.4%) stddev-sans-first:23.70 15:53:00 INFO - PROCESS | 31162 | Values: 93.0 94.0 141.0 94.0 94.0 94.0 139.0 94.0 94.0 144.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:53:00 INFO - PROCESS | 31162 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:53:00 INFO - PROCESS | 31162 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 147.0 148.0 146.0 146.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 15:53:00 INFO - PROCESS | 31162 | Values: 94.0 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:64.00 stddev:10.79 (16.9%) stddev-sans-first:11.38 15:53:00 INFO - PROCESS | 31162 | Values: 64.0 65.0 64.0 64.0 63.0 64.0 66.0 98.0 63.0 63.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 15:53:00 INFO - PROCESS | 31162 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 66.0 66.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 15:53:00 INFO - PROCESS | 31162 | Values: 79.0 81.0 79.0 78.0 79.0 80.0 80.0 80.0 79.0 79.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:134.00 stddev:14.43 (10.8%) stddev-sans-first:15.22 15:53:00 INFO - PROCESS | 31162 | Values: 134.0 133.0 135.0 134.0 133.0 131.0 132.0 137.0 179.0 134.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.50 stddev:2.91 (1.7%) stddev-sans-first:2.76 15:53:00 INFO - PROCESS | 31162 | Values: 178.0 175.0 180.0 175.0 174.0 171.0 172.0 171.0 173.0 174.0 15:53:00 INFO - PROCESS | 31162 | 15:53:00 INFO - PROCESS | 31162 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:1.72 (2.4%) stddev-sans-first:1.73 15:53:00 INFO - PROCESS | 31162 | Values: 74.0 73.0 71.0 74.0 76.0 72.0 72.0 71.0 71.0 71.0 15:53:00 INFO - PROCESS | 31162 | -------- Summary: end -------- 15:53:00 INFO - PROCESS | 31162 | 15:53:01 INFO - TEST-INFO | 31162: exit 0 15:53:01 INFO - TEST-OK | kraken | took 63321ms 15:53:01 INFO - SUITE-END | took 1181s 15:53:02 INFO - Completed test suite (00:19:41) 15:53:02 INFO - javascript benchmark 15:53:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.3695244665055, 2617.62044503547, 2632.9341766455823, 2635.2621266045503, 2648.655674762281, 4446.599806017458, 4517.390152329434, 4541.114482675879, 4566.543345665436, 4574.908501829961, 4628.421447319085, 4653.255479123341, 4658.1149581579475, 4692.976535117328, 4701.153792317382, 4200.600942910419, 4218.282891908368, 4248.702590818644, 4275.657947364219, 4353.891152721191, 4247.299195632717, 4312.82748690052, 4321.438213032301, 4321.54623764505, 4368.322909948963, 4168.166366726652, 4203.6637069034405, 4205.222033923734, 4254.0, 4260.55264197261, 4261.637760790337, 4293.785310734451, 4294.141171765628, 4294.677899157545, 4345.0, 4239.745615263063, 4247.681423893189, 4261.062566235423, 4281.507626622916, 4290.206311832321, 4374.693771436001, 4467.061916997434, 4499.415076040126, 4542.704724192917, 4562.520935301779, 4902.65681402302, 4906.730129842857, 4917.139500587383, 4924.335214745999, 4946.431160416562, 4773.474917759044, 4941.036497882914, 4948.307236986825, 4952.925918959319, 4953.95966846959, 4590.540945905416, 4623.86128416148, 4624.098300831306, 4662.603678687349, 4669.649776266793, 4948.802047918115, 4972.676776009548, 4975.975120124449, 4976.776045077981, 5020.146575082244, 4693.788779504862, 4781.593564546983, 4783.689060211075, 4784.665073444826, 4791.760411979387, 4943.357363542788, 4960.826371076995, 4998.800047998112, 5008.348914641147, 5035.647504674711, 4903.975480122576, 4909.582685471703, 4930.383702037246, 4939.777710003059, 4967.875803104951, 4739.075880203327, 4836.347093142451, 4899.559039686445, 4916.434610019822, 4957.7769000395065, 4139.648129908992, 4151.1075118848985, 4163.063310755056, 4181.289180839264, 4201.789910504463, 3620.873269435557, 3634.2913131939017, 3640.12636967126, 3670.908227294339, 3696.6488183622514, 4084.6732261419015, 4164.562720914321, 4234.280172370704, 4240.215560121387, 4257.531671516131, 4948.109340318705, 4948.653594248368, 4958.082754690394, 4973.079980203674, 5007.499250075036, 4230.85192018284, 4236.788160591958, 4243.7029407941145, 4245.448091748053, 4290.334998075304, 4315.6763242756915, 4402.273624851863, 4426.15902978433, 4429.601335879722, 4468.106378724203, 4676.134915040729, 4713.2458806590785, 4716.622670186445, 4730.763461826895, 4769.618430525619, 4941.629377796751, 4952.925706114339, 4954.207326827835, 4965.851024469272, 5012.674176178537, 4532.546745325441, 4662.53374662531, 4699.459562150259, 4705.905881882411, 4757.45289291722, 4800.927986080142, 4823.300621409806, 4832.130216561053, 4865.124277629919, 4878.195097808822, 4862.610991120772, 4884.731339776346, 4891.584215341593, 4893.339399181207, 4949.208126699711, 4643.883902902455, 4742.952570474251, 4785.545373189541, 4792.472827988849, 4813.326134341125, 4776.355192049168, 4787.210110331756, 4798.016406636701, 4799.184138696361, 4840.29815676732, 4683.437987441393, 4700.60044896174, 4715.575598196042, 4721.858344249678, 4765.356676848581, 4682.695624784378, 4824.541668541483, 4860.246661767432, 4905.730184839868, 4910.2880082388565, 4709.764511774466, 4716.952830471789, 4723.220668589644, 4731.6214702823, 4776.23580227162], "value": 4523.7236899425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.7202537521275, 574.4600075928628, 593.4125216036124, 602.2862907454669, 602.8553147244662, 33425.0, 34468.1382965426, 34495.65504344959, 34518.82740586297, 34540.481892771626, 36559.4516082259, 37097.81451092748, 37262.25475490488, 37266.627333726654, 37276.62723372765, 7522.285382888617, 7682.654280557361, 7696.576688282143, 7697.307242348187, 7701.383889288872, 7513.323800857922, 7600.5439673619485, 7614.0, 7614.162442131361, 7617.428692848031, 7807.945927299827, 7874.724384646539, 7877.9212207878045, 7879.724209652663, 7881.527108373516, 7745.806354841117, 7801.0638723352995, 7804.024496937883, 7805.9609701951695, 7807.180246074194, 7684.961575192144, 7796.922030779676, 7799.844003119906, 7802.102758182825, 7803.3367163791145, 38364.0, 38795.41806872899, 38885.22229555393, 38965.61034389676, 38982.220355592726, 3225.161458020908, 3252.0243926822095, 3297.934041319184, 3425.811580363079, 3613.4579813027995, 28376.574351384745, 28810.567841482396, 29094.27264318409, 29784.553231701542, 29824.25439364033, 3401.3537427888623, 3498.702610278129, 3522.5772907251294, 3538.0800991742076, 3572.8034958077296, 163413.0, 164302.0, 165331.0, 165341.0, 166011.0, 47675.5232447678, 48094.5190548097, 48507.514924851006, 48571.5142848574, 48583.27125093126, 57797.42202578005, 59182.40817591855, 59533.404665953654, 59540.40459595435, 59543.70228148832, 13550.661233469242, 13669.111507751964, 13737.725245495034, 13743.244121573409, 13751.0, 9888.950555247322, 10230.948845255725, 10258.538365773558, 10262.127719143808, 10747.78504429907, 17546.034968076878, 17617.150199229152, 17701.0, 17722.822771772375, 17767.20047597861, 6974.4420446364165, 6982.546134501241, 7097.615964886901, 7116.359527642537, 7178.066851309296, 889.6041261638638, 935.4340623922565, 971.2521358553875, 1002.2533212756543, 1020.4081632653043, 27024.324391889968, 28359.71640283612, 28499.430011399654, 28506.0, 28513.572296415572, 920.033964337443, 978.0610613810679, 987.8320685483485, 999.1756800639502, 1007.8941711120374, 14720.043197192148, 14991.32539035746, 15090.698186036438, 15276.312565934559, 15387.384504619913, 356253.0, 361654.0, 363904.0, 364664.0, 365528.0, 47655.28517072247, 48271.5172848267, 48317.75841120772, 48528.27207591889, 48538.27192592114, 1130.6947124276398, 1224.375568460074, 1247.3700781105665, 1254.5797157952006, 1263.1789336931067, 24440.14459493909, 25501.61747573825, 25811.483770324863, 26056.609150863133, 26064.087756928417, 35894.231105733525, 36265.81867090753, 36396.27207455783, 36462.27075458529, 36501.26997460089, 232705.0, 234145.0, 234611.0, 234618.0, 235376.0, 22195.889020555438, 22931.656025159304, 24651.137210197558, 25316.113936012152, 25508.617370739827, 35706.28587428289, 35881.46177807283, 35949.64050359568, 36687.78090519625, 37058.444123337635, 31518.0, 31687.683123168474, 34135.487967680005, 34257.97226083221, 34282.65717342795, 33340.83329583336, 33719.0, 33797.32405351928, 34102.31795364029, 34178.65821341755, 33472.16319592029, 33533.0, 33782.324353513286, 34144.48783268203, 34271.828640856635, 29724.872663006725, 30665.386692266475, 30699.846500768246, 30740.692593074677, 30816.84591577028, 23745.762542374356, 24208.0, 24229.114200162214, 24529.632055518825, 24548.631770523814], "value": 16706.43345232757, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.46862050027465, 369.9038250054987, 375.09227669040916, 375.41435360837096, 383.4650662326057, 15643.687126257482, 16319.83680163198, 16820.24308906099, 16838.326466941322, 16844.073575953316, 15281.617959551017, 16191.271392787323, 17042.14789260535, 17125.486235412925, 17153.57116072099, 5092.872678183047, 5273.419923808378, 5295.0733621616255, 5308.46915308468, 5311.760970756306, 3666.0834791302173, 3841.6926645868402, 5167.819126330579, 5628.549716022709, 5925.229720136376, 5854.29748430189, 5870.853228669296, 5893.145493903381, 5898.203742494751, 5900.763969441217, 5687.232223649796, 5810.33181184165, 5893.469587737124, 5894.115882617599, 5908.67502287374, 3343.9665603343897, 4925.630577706686, 5165.509276618715, 5170.327857378555, 5171.715555644438, 18818.62362752751, 19045.809541904542, 19124.61750764991, 20660.5867882643, 20663.896680516653, 1928.9872816771167, 1938.1665883670016, 1938.4669215965582, 2297.5864344417996, 2544.5292620865016, 12670.873291267153, 12773.808392874114, 12866.163699359511, 13065.281409522473, 13504.189748615016, 1783.3223375117502, 1862.3481781376545, 1873.7095750158746, 1888.4334699590206, 1925.422373288008, 64916.67541662262, 64968.350316496704, 66060.0, 66982.95730076426, 67052.3294767051, 9313.953430232805, 9509.90490095104, 9760.121589057018, 10218.846717299246, 10237.692869213935, 13188.208707477583, 13243.404046817916, 13287.800682989762, 13293.069485135948, 13335.199888006751, 6923.2038315593345, 6991.685374158175, 7008.088948436671, 7038.964805176044, 7055.823604409931, 6527.510436717265, 6536.509761767887, 6540.247871494744, 6807.149106361705, 7029.89455158173, 5821.94178058214, 5999.910001349983, 6053.4854537363935, 6083.969580152159, 6128.387161283836, 1576.7950166478513, 1636.8936019158716, 1644.5313085770738, 1715.1852869886704, 1737.3311275159156, 869.699953516036, 902.7472307753708, 904.263025634106, 916.3814425262921, 946.8295706772847, 15672.138032408327, 15993.840061599467, 16274.349026039063, 16392.83607163937, 16800.15999200035, 876.7545087375545, 909.9785391771513, 918.3571499949928, 954.9713508594754, 963.6627180486773, 9195.126462986005, 9679.370840895319, 9707.514624268759, 9733.659321923698, 9853.704388868346, 399866.0, 413234.0, 420125.0, 422685.0, 426907.0, 67028.32971670319, 67129.0, 68329.3167068323, 68552.6572367135, 69104.96342554866, 981.1513041219293, 985.9063388978036, 1012.3217444312328, 1018.9286749927434, 1030.3508789462592, 14288.785668215192, 14368.784468233194, 14396.136231826124, 14534.636634084232, 14736.26318684083, 30569.23576910595, 31115.0, 31138.0, 31345.373092538477, 31593.8420307897, 39007.0, 40653.390199146445, 40667.59332406638, 41704.58295417128, 41714.165716686104, 7610.695572177051, 7613.314801667876, 7613.809654758454, 7633.313001829862, 7679.424043196671, 11427.428628568372, 11701.180917335705, 11702.239354441934, 11716.23844450108, 11985.460654270404, 10182.731342246667, 10200.744981375525, 10261.58953641846, 10390.116840068678, 10456.581736730446, 9947.0, 10154.289199756242, 10176.796464070825, 10412.21908356861, 10442.895571044191, 10177.898221017695, 10420.32267902584, 10722.73193170177, 10743.785124297627, 10858.945705271422, 7439.628018599156, 7496.850062998818, 7543.622818858926, 7616.0860696716745, 7619.847603048019, 9638.180754635654, 10273.9486302568, 10344.120749736358, 10424.218183636409, 10502.264841461025], "value": 8235.402876737906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1183.2131632464411, 1432.5559076686227, 1472.8895332850038, 1604.8234694183639, 1790.1228398084943, 6827.31726827317, 7434.739784107557, 7667.84664306715, 7682.423818213629, 7694.576798276093, 7382.409407247421, 7504.737334193304, 7541.0, 7551.093868735746, 7553.735619253327, 1945.6984167454068, 2190.7042549255884, 2229.1529218896835, 2254.199759085526, 2258.8418810683174, 2279.7720227977234, 2299.6435552489306, 2301.022065622104, 2301.8849057547054, 2308.699869017034, 2231.419830843976, 2267.2744721689064, 2268.5576312619046, 2272.556851413975, 2273.545290941818, 1889.4426144287468, 2172.4568857785475, 2238.373255488466, 2239.596872562938, 2241.1371621925678, 2143.3677065265783, 2154.1275783307788, 2162.1459523488134, 2166.480044789255, 2175.3908905506482, 7585.317321441042, 7590.506617069928, 7631.1605723370385, 7650.043744531934, 7650.808729781745, 4414.9337759933305, 4574.794134263932, 4584.633229341644, 4589.954100458986, 4592.816287348502, 2948.6609039960463, 2968.4359971605327, 3015.909522714322, 3060.265536271279, 3061.4642437573334, 966.6520052780993, 1678.8489035986697, 1791.7312403139504, 1859.2748827957107, 1891.9905400473046, 9840.11438970496, 10005.749856253578, 10015.899841001643, 10073.043060909202, 10080.445575493344, 3976.204759048202, 4016.8995775105273, 4177.436046133794, 4180.749155050707, 4243.596858298457, 8099.635516401776, 8099.757007289791, 8129.227723366271, 8167.509949403055, 8305.792355191168, 3951.644352008333, 4506.459224893034, 4510.639148868148, 4514.774261286922, 4520.547945205453, 4028.657564107025, 4088.4684990950987, 4095.24238015968, 4109.938350924738, 4126.834926602963, 3453.9481907771406, 3543.0965103898343, 3569.714422846166, 3628.7097032237884, 3674.2651469706166, 1067.8611780468489, 1091.1925175370327, 1092.464692300767, 1101.6750058732694, 1110.1784679337231, 710.5488015110442, 768.8885111658778, 806.467731297341, 853.4665833853842, 878.8974918537446, 5276.577873770089, 5432.212329212242, 5544.91682624761, 5567.24842146305, 5605.691686957257, 875.5490922175085, 895.5119459894373, 931.0689310689311, 931.0689310689311, 951.1012093571509, 3666.1934374437583, 3822.57951625321, 3932.567417584121, 3964.0684439156776, 3974.3442332014893, 9150.359474836698, 9550.856737148948, 9633.759156021015, 9645.807083858424, 9682.515874206403, 9310.068993100636, 9418.387804792666, 9438.95280523593, 9503.239740820718, 9514.714558563253, 7205.783826485109, 7207.675654595451, 7224.891626625605, 7300.4159667226495, 7335.77992660221, 5339.786408543615, 5384.6769193848495, 5489.725513724377, 5504.009278329939, 5559.749811258584, 8388.245057944814, 8573.74278771638, 8627.87058194115, 8682.869756953776, 8752.387332886638, 8413.411061225655, 8548.529830859114, 8793.868091978753, 8907.10928907104, 8917.777055573402, 6615.702293396713, 6939.271376505394, 6990.510664253454, 7065.364117229474, 7220.241874603301, 7369.078865141857, 7400.629968501446, 7469.701211951461, 7470.439717021137, 7475.7009719610605, 6549.4760419167305, 6696.464282857262, 6755.392014718699, 6848.7260509579055, 6862.553933994274, 6654.600723956578, 6689.966550167218, 6724.831879203059, 6766.4248538874745, 6797.1163748714325, 6353.174087368612, 6498.862699027746, 6567.671616419256, 6568.146141001639, 6572.671366431755, 4739.668223224479, 4757.500462451531, 4912.754362281943, 4940.530649588283, 4947.356843610308, 4729.976350118227, 4752.0, 4830.396200474941, 4926.187179115406, 4968.677035992649], "value": 4198.250528963555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.19361675601544, 308.1372157957719, 308.7005604563573, 312.36433857100803, 314.21603100264815, 5006.899862002758, 5058.342415485991, 5063.670861394012, 5064.924026139611, 5077.512019110637, 4985.351904252451, 4992.350994370736, 5015.9749201254035, 5017.9498205017935, 5029.823956161535, 3752.8123593820337, 3819.3698039823394, 3927.1163988102735, 3929.4105884117466, 3986.4618276532733, 3932.154586763845, 3967.61133603238, 3969.702272329572, 3976.2643910876436, 3987.1029018470904, 3698.389765688658, 3933.5476420211758, 3940.152867133566, 3947.8223479943326, 3953.960460395388, 3804.144067584799, 3926.3128952433494, 3943.8225279862477, 3948.348522493814, 3949.545802232737, 3456.2741824216946, 3482.355764183634, 3486.7733597316346, 3488.6511348865165, 3506.6843984041557, 4825.155597770411, 4833.226683730586, 4835.202191638376, 4840.540148685869, 4856.198727210006, 4147.81334839933, 4352.086061926968, 4361.738295702268, 4368.170047690928, 4507.346434766973, 5234.81678141267, 5242.689327668083, 5247.763850626731, 5257.447967963385, 5257.947420525784, 3612.440071788877, 3614.765040272374, 3614.8554057837655, 3621.022323972513, 3623.1304486923214, 5292.735363231823, 5394.91907621386, 5460.918086228709, 5525.364583072957, 5564.8330550083565, 3792.393217085308, 3808.447775072654, 3810.1998580297895, 3812.0, 3815.503984482055, 3857.787821669835, 3859.9035024124623, 3861.942070868939, 3868.0909986153233, 3875.9806200968815, 4300.956990430118, 4423.093265880487, 4429.734215946989, 4432.135733531994, 4436.3123715824095, 5216.530512253916, 5284.682919024871, 5287.788488460418, 5318.12250978592, 5324.8136315228785, 1313.2055106660332, 1339.3771896068374, 1340.3097404836517, 1342.2215115233141, 1343.1068339554283, 832.9416940814206, 877.0922095631119, 893.4505279253212, 903.7921278106072, 913.3423934766957, 4628.449469427712, 4630.3748993886065, 4633.675642704979, 4638.257878739453, 4645.488996210414, 5397.433269506724, 5410.458954104637, 5419.756110975016, 5439.673619582838, 5455.1271796512365, 4451.154280686659, 4603.5396460353695, 4613.8846528836375, 4616.746078965622, 4630.0739852029055, 2884.956725649117, 2886.975123831052, 2898.3478717288863, 2902.3179552805072, 2905.912822615325, 5136.101182293084, 5138.794448222029, 5143.562797162208, 5151.896962060738, 5160.8967820643375, 5322.893542129135, 5511.145772405283, 5516.117421212587, 5651.463111004448, 5654.321481422174, 5204.193350030676, 5210.244514545446, 5227.790888364423, 5230.3985041719925, 5232.162853943427, 5534.7786088556, 5547.33431988164, 5549.667019978814, 5557.583181261502, 5565.7217139143695, 5201.075602027274, 5379.19312103172, 5380.811671591476, 5382.165764306539, 5403.756830942696, 5163.638545301793, 5189.636725429335, 5195.090859099718, 5216.452272511332, 5226.398964119175, 3805.733598648179, 3807.1814559869763, 3807.2004878975727, 3808.485854409619, 3822.3310920589342, 5296.920546191733, 5395.190721391823, 5431.728413579226, 5434.3207099112615, 5437.564994800486, 5261.105612045885, 5280.6303558750515, 5288.286081378965, 5312.4156342803035, 5325.627206095536, 5135.614828887774, 5303.15149576066, 5305.442928492453, 5318.494742999409, 5333.386660534088, 5222.216667499905, 5229.398619158846, 5241.711705856214, 5263.131583288715, 5275.525202731773, 5078.238264260242, 5154.278401023935, 5292.941411717748, 5354.705491198021, 5380.946190538045, 5231.267622532924, 5245.580353571629, 5251.474852514718, 5255.763490643007, 5283.286756287852], "value": 3970.3533996358738, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.7238951056289, 675.6722989350168, 685.1743648903072, 727.5561907236585, 782.647808486181, 12179.147459677826, 12271.263724176533, 12275.938620306897, 12291.262524248552, 12293.754124917508, 11876.703082422944, 11915.582954596592, 11931.58239461619, 11947.044236461084, 12962.222266664006, 804.6057431858405, 811.0672726364669, 812.6789917982394, 812.8049268175654, 812.8496228197773, 633.531186921677, 788.9368850491976, 797.0873350014231, 803.3613277444446, 808.4260175275532, 841.8905542279496, 843.87763774253, 844.2275318083946, 846.1665259719172, 847.5846835050811, 828.6892415344246, 828.9709860154866, 829.9128591497927, 831.2186544648011, 837.5142417397925, 486.7858142417325, 593.9605690042425, 601.9006863867456, 602.5842168903487, 616.3251239892355, 13069.673258168526, 13098.0, 13133.934330328382, 13148.40832162555, 13196.340182990909, 12426.875731242662, 12959.87040129596, 13236.272005039718, 13241.856592258711, 13299.202047877061, 10083.0, 10096.848547271797, 10163.4918254087, 10317.226208034352, 10471.0, 3342.2814094969453, 3398.3033478137168, 3398.4222682144095, 3422.8117453540044, 3472.409690352646, 46392.536074639494, 46416.303755443696, 46928.0, 46978.0, 47080.7645961768, 10251.231157663206, 10261.692149235534, 10381.11760500366, 10656.62701805433, 10811.567537298577, 18604.534886627673, 18631.720524192147, 18653.160607772683, 18731.063446827604, 18791.0, 6809.148856392951, 6943.479239057091, 7054.294570542905, 7058.647067646597, 7100.92899071013, 3885.1841113365945, 3903.980480097581, 3924.7841368724994, 3977.900552486211, 4049.5140583130215, 2836.290927268183, 2867.9283017924304, 2899.536074228113, 2900.2024443277846, 2900.5939168516425, 489.11714355587793, 489.87263311539255, 496.87329730918384, 501.4609295007881, 502.52260352665115, 607.7417097733446, 626.8338890194102, 633.4773811605444, 634.4987459906714, 636.5599940415565, 7615.428842836809, 8008.256551394069, 8177.914631768861, 8235.176482351717, 8541.231289184003, 584.3221862639318, 600.5675913342386, 609.5002098279368, 628.7862126876884, 629.8519847835755, 3914.451976723261, 3949.881503554898, 4081.673466122703, 4192.203481338536, 4197.181549597799, 43159.13681726411, 46677.53322466732, 46704.76647616808, 46784.0, 46840.5315946843, 41335.58664413378, 41580.59452271186, 41647.58352416498, 42388.57611423908, 43136.0, 31310.68689313123, 32432.513512297333, 35275.0, 35819.4627080594, 36174.81912590473, 8232.547209903512, 8268.0, 8318.334533237205, 8350.582470876554, 8475.32197424217, 27662.771037142673, 27674.308142296602, 27913.0, 28008.43983120367, 28113.156605301872, 33903.0, 34509.654903450646, 36185.45721814122, 36594.45108323324, 36757.816210918776, 10051.899481005388, 10524.684259472227, 10734.516946737573, 10917.181211409017, 10925.28214680595, 11866.347350895783, 11868.643940681794, 11911.344876031555, 11967.461464234304, 12204.450799713857, 11325.0, 11363.261388009752, 11574.18980671345, 12031.15781895259, 12057.879421205676, 11382.0, 11423.885761142283, 11875.465604047666, 11917.642470725892, 12226.816597750863, 11085.05777008931, 11172.888271117185, 11525.711857203636, 11943.641690749291, 11953.0, 9619.951900240454, 9671.274654400808, 9855.507224638883, 9865.605375784888, 10050.0, 9387.81224375495, 10005.299629025898, 10085.092341689284, 10086.8486972694, 10122.342047766871], "value": 5953.508989798471, "unit": "score"}], "name": "dromaeo_css", "value": 6287.290697305892, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 110.0, 112.0, 113.0, 113.0, 103.0, 112.0, 112.0, 114.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 161.0, 195.0, 138.0, 169.0, 160.0, 133.0, 185.0, 131.0], "value": 156.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 161.0, 159.0, 161.0, 161.0, 161.0, 162.0, 163.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 82.0, 111.0, 74.0, 74.0, 73.0, 117.0, 102.0, 73.0], "value": 85.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 141.0, 94.0, 94.0, 94.0, 139.0, 94.0, 94.0, 144.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 63.0, 64.0, 66.0, 98.0, 63.0, 63.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 78.0, 79.0, 80.0, 80.0, 80.0, 79.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 135.0, 134.0, 133.0, 131.0, 132.0, 137.0, 179.0, 134.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 180.0, 175.0, 174.0, 171.0, 172.0, 171.0, 173.0, 174.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 71.0, 74.0, 76.0, 72.0, 72.0, 71.0, 71.0, 71.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1578.0, "alertThreshold": 2.0}]} 15:53:02 INFO - Return code: 0 15:53:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:53:02 ERROR - # TBPL SUCCESS # 15:53:02 INFO - Running post-action listener: _resource_record_post_action 15:53:02 INFO - Running post-run listener: _resource_record_post_run 15:53:03 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 36864; Write bytes: 528150528; Read time: 528; Write time: 621892 15:53:03 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 28672; Write bytes: 205926400; Read time: 288; Write time: 342888 15:53:03 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283193344; Read time: 240; Write time: 257392 15:53:03 INFO - Running post-run listener: _upload_blobber_files 15:53:03 INFO - Blob upload gear active. 15:53:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:53:03 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 15:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:53:03 INFO - (blobuploader) - INFO - Open directory for files ... 15:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:53:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:53:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:05 INFO - (blobuploader) - INFO - Done attempting. 15:53:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:53:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:53:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:05 INFO - (blobuploader) - INFO - Done attempting. 15:53:05 INFO - (blobuploader) - INFO - Iteration through files over. 15:53:05 INFO - Return code: 0 15:53:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:53:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:53:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a2bd462ae479038c00e9ee8dcb9b3478bd2fa5d1dca6391d232d53258a2fc6d40f05ed0cd25745f2490e7caf8fd4ab3c275618b197290152498f5b08f913e52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a489d29724f8adb453bfc274836c009e56b4c4a0f858ea8f8992d00545eb0e6bfeb0b182bbd91a7bd1aabc9031e24d36fcd5ff7bbde7ee56d42c21abf950e44b"} 15:53:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:53:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:53:05 INFO - Contents: 15:53:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a2bd462ae479038c00e9ee8dcb9b3478bd2fa5d1dca6391d232d53258a2fc6d40f05ed0cd25745f2490e7caf8fd4ab3c275618b197290152498f5b08f913e52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a489d29724f8adb453bfc274836c009e56b4c4a0f858ea8f8992d00545eb0e6bfeb0b182bbd91a7bd1aabc9031e24d36fcd5ff7bbde7ee56d42c21abf950e44b"} 15:53:05 INFO - Running post-run listener: copy_logs_to_upload_dir 15:53:05 INFO - Copying logs to upload dir... 15:53:05 INFO - mkdir: /builds/slave/test/build/upload/logs 15:53:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.076863 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-20 15:53:05.788574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:53:05.792454) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a2bd462ae479038c00e9ee8dcb9b3478bd2fa5d1dca6391d232d53258a2fc6d40f05ed0cd25745f2490e7caf8fd4ab3c275618b197290152498f5b08f913e52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a489d29724f8adb453bfc274836c009e56b4c4a0f858ea8f8992d00545eb0e6bfeb0b182bbd91a7bd1aabc9031e24d36fcd5ff7bbde7ee56d42c21abf950e44b"} build_url:https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/LK_qrQCoSk2ArQA5DyvTaw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a2bd462ae479038c00e9ee8dcb9b3478bd2fa5d1dca6391d232d53258a2fc6d40f05ed0cd25745f2490e7caf8fd4ab3c275618b197290152498f5b08f913e52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a489d29724f8adb453bfc274836c009e56b4c4a0f858ea8f8992d00545eb0e6bfeb0b182bbd91a7bd1aabc9031e24d36fcd5ff7bbde7ee56d42c21abf950e44b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:53:05.816669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:53:05.816995) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1461191520.264901-422996552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:53:05.899131) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:53:05.899497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:53:05.899818) ========= ========= Total master_lag: 0.17 =========