builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1467325485.45 results: success (0) buildid: 20160630122427 builduid: 1b4995dda5434b7a9feb90fda4023da6 revision: 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:45.454370) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:45.454841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:45.455128) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:45.470971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:45.471383) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 15:24:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.3M=0s 2016-06-30 15:24:45 (33.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151841 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:45.658964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:45.659310) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019729 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:45.709220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 15:24:45.709595) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 15:24:45,763 truncating revision to first 12 chars 2016-06-30 15:24:45,763 Setting DEBUG logging. 2016-06-30 15:24:45,763 attempt 1/10 2016-06-30 15:24:45,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0b4f2a4e4229?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 15:24:46,634 unpacking tar archive at: mozilla-beta-0b4f2a4e4229/testing/mozharness/ program finished with exit code 0 elapsedTime=1.199615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 15:24:46.924213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:46.924580) ========= script_repo_revision: 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:46.924998) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:46.925290) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:24:46.936557) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-30 15:24:46.936942) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:24:47 INFO - MultiFileLogger online at 20160630 15:24:47 in /builds/slave/test 15:24:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:24:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:47 INFO - {'append_to_log': False, 15:24:47 INFO - 'base_work_dir': '/builds/slave/test', 15:24:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:24:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:47 INFO - 'branch': 'Mozilla-Beta', 15:24:47 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:47 INFO - 'config_files': ('talos/linux_config.py',), 15:24:47 INFO - 'default_actions': ('clobber', 15:24:47 INFO - 'read-buildbot-config', 15:24:47 INFO - 'download-and-extract', 15:24:47 INFO - 'populate-webroot', 15:24:47 INFO - 'create-virtualenv', 15:24:47 INFO - 'install', 15:24:47 INFO - 'run-tests'), 15:24:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:47 INFO - 'download_minidump_stackwalk': True, 15:24:47 INFO - 'download_symbols': 'ondemand', 15:24:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:24:47 INFO - 'tooltool.py': '/tools/tooltool.py', 15:24:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:24:47 INFO - '/tools/misc-python/virtualenv.py')}, 15:24:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:47 INFO - 'installer_path': 'installer.exe', 15:24:47 INFO - 'log_level': 'info', 15:24:47 INFO - 'log_name': 'talos', 15:24:47 INFO - 'log_to_console': True, 15:24:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:24:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:24:47 INFO - 'opt_config_files': (), 15:24:47 INFO - 'pip_index': False, 15:24:47 INFO - 'sps_profile': False, 15:24:47 INFO - 'sps_profile_interval': 0, 15:24:47 INFO - 'suite': 'dromaeojs', 15:24:47 INFO - 'system_bits': '32', 15:24:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:47 INFO - 'title': 'talos-linux64-ix-004', 15:24:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:47 INFO - 'use_talos_json': True, 15:24:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:47 INFO - 'work_dir': 'build'} 15:24:47 INFO - ##### 15:24:47 INFO - ##### Running clobber step. 15:24:47 INFO - ##### 15:24:47 INFO - Running pre-action listener: _resource_record_pre_action 15:24:47 INFO - Running main action method: clobber 15:24:47 INFO - rmtree: /builds/slave/test/build 15:24:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:47 INFO - Running post-action listener: _resource_record_post_action 15:24:47 INFO - ##### 15:24:47 INFO - ##### Running read-buildbot-config step. 15:24:47 INFO - ##### 15:24:47 INFO - Running pre-action listener: _resource_record_pre_action 15:24:47 INFO - Running main action method: read_buildbot_config 15:24:47 INFO - Using buildbot properties: 15:24:47 INFO - { 15:24:47 INFO - "project": "", 15:24:47 INFO - "product": "firefox", 15:24:47 INFO - "script_repo_revision": "production", 15:24:47 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:24:47 INFO - "repository": "", 15:24:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:24:47 INFO - "buildid": "20160630122427", 15:24:47 INFO - "pgo_build": "True", 15:24:47 INFO - "basedir": "/builds/slave/test", 15:24:47 INFO - "buildnumber": 145, 15:24:47 INFO - "slavename": "talos-linux64-ix-004", 15:24:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:24:47 INFO - "platform": "ubuntu64_hw", 15:24:47 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:24:47 INFO - "branch": "mozilla-beta", 15:24:47 INFO - "repo_path": "releases/mozilla-beta", 15:24:47 INFO - "revision": "0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1", 15:24:47 INFO - "stage_platform": "linux64-pgo", 15:24:47 INFO - "builduid": "1b4995dda5434b7a9feb90fda4023da6", 15:24:47 INFO - "slavebuilddir": "test" 15:24:47 INFO - } 15:24:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 15:24:47 INFO - Running post-action listener: _resource_record_post_action 15:24:47 INFO - ##### 15:24:47 INFO - ##### Running download-and-extract step. 15:24:47 INFO - ##### 15:24:47 INFO - Running pre-action listener: _resource_record_pre_action 15:24:47 INFO - Running main action method: download_and_extract 15:24:47 INFO - mkdir: /builds/slave/test/build/tests 15:24: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:24:47 INFO - https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:24:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:24:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:24:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:24:48 INFO - Downloaded 1327 bytes. 15:24:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:24:48 INFO - Using the following test package requirements: 15:24:48 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:24:48 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:24:48 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:24:48 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:24:48 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 15:24:48 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:24:48 INFO - u'jsshell-linux-x86_64.zip'], 15:24:48 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:24:48 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:24:48 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:24:48 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:24:48 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 15:24:48 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:24:48 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 15:24:48 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:24:48 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:24:48 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:24:48 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:24:48 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:24:48 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:24:48 INFO - https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:24:49 INFO - Downloaded 24236612 bytes. 15:24:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:24:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:24:50 INFO - Return code: 0 15:24:50 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:24: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:24:50 INFO - https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:24:51 INFO - Downloaded 24236612 bytes. 15:24:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:24:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:24:54 INFO - Return code: 0 15:24:54 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:24:54 INFO - https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:24:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:24:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:24:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:24:55 INFO - Downloaded 10840145 bytes. 15:24:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:24:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:24:55 INFO - Return code: 0 15:24:55 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:24:55 INFO - https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:24:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:24:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:24:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:24:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:24:56 INFO - Downloaded 56012724 bytes. 15:24:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:24:56 INFO - mkdir: /builds/slave/test/properties 15:24:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:56 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:56 INFO - Contents: 15:24:56 INFO - build_url:https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:24:57 INFO - Running post-action listener: _resource_record_post_action 15:24:57 INFO - Running post-action listener: set_extra_try_arguments 15:24:57 INFO - ##### 15:24:57 INFO - ##### Running populate-webroot step. 15:24:57 INFO - ##### 15:24:57 INFO - Running pre-action listener: _resource_record_pre_action 15:24:57 INFO - Running main action method: populate_webroot 15:24:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:24:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:24:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:24:57 INFO - '--tppagecycles', 15:24:57 INFO - '7'], 15:24:57 INFO - 'tests': ['tsvgm']}}, 15:24:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:24:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:24:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:57 INFO - 'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:57 INFO - 'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['damp', 'tps']}, 15:24:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:57 INFO - 'tests': ['damp', 'tps']}, 15:24:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['dromaeo_dom']}, 15:24:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['a11yr', 15:24:57 INFO - 'ts_paint', 15:24:57 INFO - 'tpaint', 15:24:57 INFO - 'sessionrestore', 15:24:57 INFO - 'sessionrestore_no_auto_restore', 15:24:57 INFO - 'tabpaint']}, 15:24:57 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:57 INFO - 'ts_paint', 15:24:57 INFO - 'tpaint', 15:24:57 INFO - 'sessionrestore', 15:24:57 INFO - 'sessionrestore_no_auto_restore', 15:24:57 INFO - 'tabpaint']}, 15:24:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:24:57 INFO - 'ts_paint', 15:24:57 INFO - 'tpaint', 15:24:57 INFO - 'sessionrestore', 15:24:57 INFO - 'sessionrestore_no_auto_restore', 15:24:57 INFO - 'tabpaint']}, 15:24:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:24:57 INFO - 'ts_paint', 15:24:57 INFO - 'tpaint', 15:24:57 INFO - 'sessionrestore', 15:24:57 INFO - 'sessionrestore_no_auto_restore', 15:24:57 INFO - 'tabpaint']}, 15:24:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['a11yr', 15:24:57 INFO - 'ts_paint', 15:24:57 INFO - 'tpaint', 15:24:57 INFO - 'sessionrestore', 15:24:57 INFO - 'sessionrestore_no_auto_restore', 15:24:57 INFO - 'tabpaint']}, 15:24:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['a11yr', 15:24:57 INFO - 'ts_paint', 15:24:57 INFO - 'tpaint', 15:24:57 INFO - 'sessionrestore', 15:24:57 INFO - 'sessionrestore_no_auto_restore', 15:24:57 INFO - 'tabpaint']}, 15:24:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['tsvgx', 15:24:57 INFO - 'tsvgr_opacity', 15:24:57 INFO - 'tart', 15:24:57 INFO - 'tscrollx', 15:24:57 INFO - 'cart']}, 15:24:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:57 INFO - 'tsvgr_opacity', 15:24:57 INFO - 'tart', 15:24:57 INFO - 'tscrollx', 15:24:57 INFO - 'cart']}, 15:24:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:57 INFO - 'talos_options': ['--disable-e10s'], 15:24:57 INFO - 'tests': ['tp5o']}, 15:24:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:57 INFO - 'tests': ['tp5o']}, 15:24:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:57 INFO - 'talos_options': ['--disable-e10s', 15:24:57 INFO - '--xperf_path', 15:24:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:57 INFO - 'tests': ['tp5n']}, 15:24:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:57 INFO - 'talos_options': ['--xperf_path', 15:24:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:57 INFO - 'tests': ['tp5n']}}, 15:24:57 INFO - 'talos.zip': {'path': '', 15:24:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:24:57 INFO - Running post-action listener: _resource_record_post_action 15:24:57 INFO - ##### 15:24:57 INFO - ##### Running create-virtualenv step. 15:24:57 INFO - ##### 15:24:57 INFO - Running pre-action listener: _resource_record_pre_action 15:24:57 INFO - Running main action method: create_virtualenv 15:24:57 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:57 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:24:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:24:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:57 INFO - Using real prefix '/usr' 15:24:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:59 INFO - Installing distribute.............................................................................................................................................................................................done. 15:25:02 INFO - Installing pip.................done. 15:25:02 INFO - Return code: 0 15:25:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:25:02 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:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:02 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:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:02 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 0x7f3c6a1d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', '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:25:02 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:25:02 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:25:02 INFO - Using env: {'DISPLAY': ':0', 15:25:02 INFO - 'HOME': '/home/cltbld', 15:25:02 INFO - 'LANG': 'en_US.UTF-8', 15:25:02 INFO - 'LANGUAGE': 'en_US:en', 15:25:02 INFO - 'LOGNAME': 'cltbld', 15:25:02 INFO - 'MAIL': '/var/mail/cltbld', 15:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:02 INFO - 'MOZ_NO_REMOTE': '1', 15:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:02 INFO - 'NO_EM_RESTART': '1', 15:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:02 INFO - 'PWD': '/builds/slave/test', 15:25:02 INFO - 'SHELL': '/bin/bash', 15:25:02 INFO - 'SHLVL': '1', 15:25:02 INFO - 'TERM': 'linux', 15:25:02 INFO - 'TMOUT': '86400', 15:25:02 INFO - 'USER': 'cltbld', 15:25:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:02 INFO - '_': '/tools/buildbot/bin/python'} 15:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:02 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:25:02 INFO - Cleaning up... 15:25:02 INFO - Return code: 0 15:25:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:25:02 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:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:02 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:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:02 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 0x7f3c6a1d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', '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:25:02 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:25:02 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:25:02 INFO - Using env: {'DISPLAY': ':0', 15:25:02 INFO - 'HOME': '/home/cltbld', 15:25:02 INFO - 'LANG': 'en_US.UTF-8', 15:25:02 INFO - 'LANGUAGE': 'en_US:en', 15:25:02 INFO - 'LOGNAME': 'cltbld', 15:25:02 INFO - 'MAIL': '/var/mail/cltbld', 15:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:02 INFO - 'MOZ_NO_REMOTE': '1', 15:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:02 INFO - 'NO_EM_RESTART': '1', 15:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:02 INFO - 'PWD': '/builds/slave/test', 15:25:02 INFO - 'SHELL': '/bin/bash', 15:25:02 INFO - 'SHLVL': '1', 15:25:02 INFO - 'TERM': 'linux', 15:25:02 INFO - 'TMOUT': '86400', 15:25:02 INFO - 'USER': 'cltbld', 15:25:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:02 INFO - '_': '/tools/buildbot/bin/python'} 15:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:02 INFO - Downloading/unpacking psutil>=0.7.1 15:25: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:25: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:25: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:25: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:25: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:25: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:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:25:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:04 INFO - Installing collected packages: psutil 15:25:04 INFO - Running setup.py install for psutil 15:25:04 INFO - building 'psutil._psutil_linux' extension 15:25:04 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:25:06 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:25:06 INFO - building 'psutil._psutil_posix' extension 15:25:06 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:25:07 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:25:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:07 INFO - Successfully installed psutil 15:25:07 INFO - Cleaning up... 15:25:07 INFO - Return code: 0 15:25:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:07 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 0x7f3c6a1d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', '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:25:07 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:25:07 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:25:07 INFO - Using env: {'DISPLAY': ':0', 15:25:07 INFO - 'HOME': '/home/cltbld', 15:25:07 INFO - 'LANG': 'en_US.UTF-8', 15:25:07 INFO - 'LANGUAGE': 'en_US:en', 15:25:07 INFO - 'LOGNAME': 'cltbld', 15:25:07 INFO - 'MAIL': '/var/mail/cltbld', 15:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:07 INFO - 'MOZ_NO_REMOTE': '1', 15:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:07 INFO - 'NO_EM_RESTART': '1', 15:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:07 INFO - 'PWD': '/builds/slave/test', 15:25:07 INFO - 'SHELL': '/bin/bash', 15:25:07 INFO - 'SHLVL': '1', 15:25:07 INFO - 'TERM': 'linux', 15:25:07 INFO - 'TMOUT': '86400', 15:25:07 INFO - 'USER': 'cltbld', 15:25:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:07 INFO - '_': '/tools/buildbot/bin/python'} 15:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:25:09 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:25:09 INFO - Installing collected packages: mozsystemmonitor 15:25:09 INFO - Running setup.py install for mozsystemmonitor 15:25:09 INFO - Successfully installed mozsystemmonitor 15:25:09 INFO - Cleaning up... 15:25:09 INFO - Return code: 0 15:25:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:25:09 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:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:09 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:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:09 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 0x7f3c6a1d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', '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:25:09 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:25:09 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:25:09 INFO - Using env: {'DISPLAY': ':0', 15:25:09 INFO - 'HOME': '/home/cltbld', 15:25:09 INFO - 'LANG': 'en_US.UTF-8', 15:25:09 INFO - 'LANGUAGE': 'en_US:en', 15:25:09 INFO - 'LOGNAME': 'cltbld', 15:25:09 INFO - 'MAIL': '/var/mail/cltbld', 15:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:09 INFO - 'MOZ_NO_REMOTE': '1', 15:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:09 INFO - 'NO_EM_RESTART': '1', 15:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:09 INFO - 'PWD': '/builds/slave/test', 15:25:09 INFO - 'SHELL': '/bin/bash', 15:25:09 INFO - 'SHLVL': '1', 15:25:09 INFO - 'TERM': 'linux', 15:25:09 INFO - 'TMOUT': '86400', 15:25:09 INFO - 'USER': 'cltbld', 15:25:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:09 INFO - '_': '/tools/buildbot/bin/python'} 15:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:09 INFO - Downloading/unpacking blobuploader==1.2.4 15:25:09 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:25:09 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:25:09 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:25:09 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:25:09 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:25:09 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:25:11 INFO - Downloading blobuploader-1.2.4.tar.gz 15:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:25:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:25:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:25:12 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:25:12 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:25:12 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:25:12 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:25:12 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:25:12 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:25:12 INFO - Downloading docopt-0.6.1.tar.gz 15:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:25:12 INFO - Installing collected packages: blobuploader, requests, docopt 15:25:12 INFO - Running setup.py install for blobuploader 15:25:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:25:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:25:12 INFO - Running setup.py install for requests 15:25:13 INFO - Running setup.py install for docopt 15:25:13 INFO - Successfully installed blobuploader requests docopt 15:25:13 INFO - Cleaning up... 15:25:13 INFO - Return code: 0 15:25:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:13 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:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:13 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:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:13 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 0x7f3c6a1d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', '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:25:13 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:25:13 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:25:13 INFO - Using env: {'DISPLAY': ':0', 15:25:13 INFO - 'HOME': '/home/cltbld', 15:25:13 INFO - 'LANG': 'en_US.UTF-8', 15:25:13 INFO - 'LANGUAGE': 'en_US:en', 15:25:13 INFO - 'LOGNAME': 'cltbld', 15:25:13 INFO - 'MAIL': '/var/mail/cltbld', 15:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:13 INFO - 'MOZ_NO_REMOTE': '1', 15:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:13 INFO - 'NO_EM_RESTART': '1', 15:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:13 INFO - 'PWD': '/builds/slave/test', 15:25:13 INFO - 'SHELL': '/bin/bash', 15:25:13 INFO - 'SHLVL': '1', 15:25:13 INFO - 'TERM': 'linux', 15:25:13 INFO - 'TMOUT': '86400', 15:25:13 INFO - 'USER': 'cltbld', 15:25:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:13 INFO - '_': '/tools/buildbot/bin/python'} 15:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:13 INFO - Running setup.py (path:/tmp/pip-TBb8z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:13 INFO - Running setup.py (path:/tmp/pip-T5JZaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:13 INFO - Running setup.py (path:/tmp/pip-uGT2Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:13 INFO - Running setup.py (path:/tmp/pip-WHK1bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:13 INFO - Running setup.py (path:/tmp/pip-OV4F0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:13 INFO - Running setup.py (path:/tmp/pip-GuwNkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:13 INFO - Running setup.py (path:/tmp/pip-Tb2qF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:13 INFO - Running setup.py (path:/tmp/pip-0YClgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:14 INFO - Running setup.py (path:/tmp/pip-vOFZOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:14 INFO - Running setup.py (path:/tmp/pip-RzVbOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:14 INFO - Running setup.py (path:/tmp/pip-TQeT9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:14 INFO - Running setup.py (path:/tmp/pip-RbdGgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:14 INFO - Running setup.py (path:/tmp/pip-XbZarL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:14 INFO - Running setup.py (path:/tmp/pip-_q3BZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:14 INFO - Running setup.py (path:/tmp/pip-ujTlCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:14 INFO - Running setup.py (path:/tmp/pip-pi2W5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:14 INFO - Running setup.py (path:/tmp/pip-YZHHIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:14 INFO - Running setup.py install for manifestparser 15:25:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:14 INFO - Running setup.py install for mozcrash 15:25:14 INFO - Running setup.py install for mozdebug 15:25:14 INFO - Running setup.py install for mozdevice 15:25:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Running setup.py install for mozfile 15:25:15 INFO - Running setup.py install for mozhttpd 15:25:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Running setup.py install for mozinfo 15:25:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Running setup.py install for mozInstall 15:25:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Running setup.py install for mozleak 15:25:15 INFO - Running setup.py install for mozlog 15:25:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Running setup.py install for moznetwork 15:25:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:15 INFO - Running setup.py install for mozprocess 15:25:15 INFO - Running setup.py install for mozprofile 15:25:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:16 INFO - Running setup.py install for mozrunner 15:25:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:16 INFO - Running setup.py install for mozscreenshot 15:25:16 INFO - Running setup.py install for moztest 15:25:16 INFO - Running setup.py install for mozversion 15:25:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:16 INFO - Cleaning up... 15:25:16 INFO - Return code: 0 15:25:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:16 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 0x7f3c6a1d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', '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:25:16 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:25:16 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:25:16 INFO - Using env: {'DISPLAY': ':0', 15:25:16 INFO - 'HOME': '/home/cltbld', 15:25:16 INFO - 'LANG': 'en_US.UTF-8', 15:25:16 INFO - 'LANGUAGE': 'en_US:en', 15:25:16 INFO - 'LOGNAME': 'cltbld', 15:25:16 INFO - 'MAIL': '/var/mail/cltbld', 15:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:16 INFO - 'MOZ_NO_REMOTE': '1', 15:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:16 INFO - 'NO_EM_RESTART': '1', 15:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:16 INFO - 'PWD': '/builds/slave/test', 15:25:16 INFO - 'SHELL': '/bin/bash', 15:25:16 INFO - 'SHLVL': '1', 15:25:16 INFO - 'TERM': 'linux', 15:25:16 INFO - 'TMOUT': '86400', 15:25:16 INFO - 'USER': 'cltbld', 15:25:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:16 INFO - '_': '/tools/buildbot/bin/python'} 15:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:16 INFO - Running setup.py (path:/tmp/pip-Xdd7e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:16 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:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:16 INFO - Running setup.py (path:/tmp/pip-w2oIrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:16 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:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:16 INFO - Running setup.py (path:/tmp/pip-MH7Cc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:16 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:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:16 INFO - Running setup.py (path:/tmp/pip-W9fBUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:17 INFO - Running setup.py (path:/tmp/pip-a3JLg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:17 INFO - Running setup.py (path:/tmp/pip-YnGQ9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:17 INFO - Running setup.py (path:/tmp/pip-hvDUGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:17 INFO - Running setup.py (path:/tmp/pip-Sz0Efh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:17 INFO - Running setup.py (path:/tmp/pip-gPwVMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:17 INFO - Running setup.py (path:/tmp/pip-N5C8P7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:17 INFO - Running setup.py (path:/tmp/pip-PdVyNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:17 INFO - Running setup.py (path:/tmp/pip-_0rgJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:17 INFO - Running setup.py (path:/tmp/pip-gT7sgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:17 INFO - Running setup.py (path:/tmp/pip-1CcIS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:17 INFO - Running setup.py (path:/tmp/pip-BUJoLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:17 INFO - Running setup.py (path:/tmp/pip-dEzp3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:17 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:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:17 INFO - Running setup.py (path:/tmp/pip-9FImKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:17 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:25:17 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:25:17 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:25:17 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:25:17 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:25:17 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:25:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:19 INFO - Downloading blessings-1.6.tar.gz 15:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:19 INFO - Installing collected packages: blessings 15:25:19 INFO - Running setup.py install for blessings 15:25:20 INFO - Successfully installed blessings 15:25:20 INFO - Cleaning up... 15:25:20 INFO - Return code: 0 15:25:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:20 INFO - Reading from file tmpfile_stdout 15:25:20 INFO - Current package versions: 15:25:20 INFO - argparse == 1.2.1 15:25:20 INFO - blessings == 1.6 15:25:20 INFO - blobuploader == 1.2.4 15:25:20 INFO - docopt == 0.6.1 15:25:20 INFO - manifestparser == 1.1 15:25:20 INFO - mozInstall == 1.12 15:25:20 INFO - mozcrash == 0.17 15:25:20 INFO - mozdebug == 0.1 15:25:20 INFO - mozdevice == 0.48 15:25:20 INFO - mozfile == 1.2 15:25:20 INFO - mozhttpd == 0.7 15:25:20 INFO - mozinfo == 0.9 15:25:20 INFO - mozleak == 0.1 15:25:20 INFO - mozlog == 3.1 15:25:20 INFO - moznetwork == 0.27 15:25:20 INFO - mozprocess == 0.22 15:25:20 INFO - mozprofile == 0.28 15:25:20 INFO - mozrunner == 6.11 15:25:20 INFO - mozscreenshot == 0.1 15:25:20 INFO - mozsystemmonitor == 0.0 15:25:20 INFO - moztest == 0.7 15:25:20 INFO - mozversion == 1.4 15:25:20 INFO - psutil == 3.1.1 15:25:20 INFO - requests == 1.2.3 15:25:20 INFO - wsgiref == 0.1.2 15:25:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:20 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:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:20 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:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:20 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 0x7f3c6a1d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', '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:25:20 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:25:20 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:25:20 INFO - Using env: {'DISPLAY': ':0', 15:25:20 INFO - 'HOME': '/home/cltbld', 15:25:20 INFO - 'LANG': 'en_US.UTF-8', 15:25:20 INFO - 'LANGUAGE': 'en_US:en', 15:25:20 INFO - 'LOGNAME': 'cltbld', 15:25:20 INFO - 'MAIL': '/var/mail/cltbld', 15:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:20 INFO - 'MOZ_NO_REMOTE': '1', 15:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:20 INFO - 'NO_EM_RESTART': '1', 15:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:20 INFO - 'PWD': '/builds/slave/test', 15:25:20 INFO - 'SHELL': '/bin/bash', 15:25:20 INFO - 'SHLVL': '1', 15:25:20 INFO - 'TERM': 'linux', 15:25:20 INFO - 'TMOUT': '86400', 15:25:20 INFO - 'USER': 'cltbld', 15:25:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:20 INFO - '_': '/tools/buildbot/bin/python'} 15:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:20 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:25:20 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:25:20 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:25:20 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:25:20 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:25:20 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:25:20 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:25:20 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:25:20 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:25:20 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:25:20 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:25:20 INFO - Cleaning up... 15:25:20 INFO - Return code: 0 15:25:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25:20 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:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:20 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:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:20 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 0x7f3c6a1d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', '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:25:20 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:25:20 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:25:20 INFO - Using env: {'DISPLAY': ':0', 15:25:20 INFO - 'HOME': '/home/cltbld', 15:25:20 INFO - 'LANG': 'en_US.UTF-8', 15:25:20 INFO - 'LANGUAGE': 'en_US:en', 15:25:20 INFO - 'LOGNAME': 'cltbld', 15:25:20 INFO - 'MAIL': '/var/mail/cltbld', 15:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:20 INFO - 'MOZ_NO_REMOTE': '1', 15:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:20 INFO - 'NO_EM_RESTART': '1', 15:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:20 INFO - 'PWD': '/builds/slave/test', 15:25:20 INFO - 'SHELL': '/bin/bash', 15:25:20 INFO - 'SHLVL': '1', 15:25:20 INFO - 'TERM': 'linux', 15:25:20 INFO - 'TMOUT': '86400', 15:25:20 INFO - 'USER': 'cltbld', 15:25:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:20 INFO - '_': '/tools/buildbot/bin/python'} 15:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:20 INFO - Downloading/unpacking jsonschema 15:25:20 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:25:20 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:25:20 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:25:20 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:25:20 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:25:20 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:25:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:25:22 INFO - Downloading/unpacking functools32 (from jsonschema) 15:25:22 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:25:22 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:25:22 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:25:22 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:25:22 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:25:22 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:25:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:22 INFO - warning: no files found matching '*.txt' 15:25:22 INFO - no previously-included directories found matching 'build' 15:25:22 INFO - no previously-included directories found matching 'dist' 15:25:22 INFO - no previously-included directories found matching '.git*' 15:25:22 INFO - Installing collected packages: jsonschema, functools32 15:25:22 INFO - Running setup.py install for functools32 15:25:23 INFO - warning: no files found matching '*.txt' 15:25:23 INFO - no previously-included directories found matching 'build' 15:25:23 INFO - no previously-included directories found matching 'dist' 15:25:23 INFO - no previously-included directories found matching '.git*' 15:25:23 INFO - Successfully installed jsonschema functools32 15:25:23 INFO - Cleaning up... 15:25:23 INFO - Return code: 0 15:25:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:25:23 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:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:23 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:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:23 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 0x7f3c6a1d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', '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:25:23 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:25:23 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:25:23 INFO - Using env: {'DISPLAY': ':0', 15:25:23 INFO - 'HOME': '/home/cltbld', 15:25:23 INFO - 'LANG': 'en_US.UTF-8', 15:25:23 INFO - 'LANGUAGE': 'en_US:en', 15:25:23 INFO - 'LOGNAME': 'cltbld', 15:25:23 INFO - 'MAIL': '/var/mail/cltbld', 15:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:23 INFO - 'MOZ_NO_REMOTE': '1', 15:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:23 INFO - 'NO_EM_RESTART': '1', 15:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:23 INFO - 'PWD': '/builds/slave/test', 15:25:23 INFO - 'SHELL': '/bin/bash', 15:25:23 INFO - 'SHLVL': '1', 15:25:23 INFO - 'TERM': 'linux', 15:25:23 INFO - 'TMOUT': '86400', 15:25:23 INFO - 'USER': 'cltbld', 15:25:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:23 INFO - '_': '/tools/buildbot/bin/python'} 15:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:23 INFO - Downloading/unpacking flake8 15:25:23 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:25:23 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:25:23 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:25:23 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:25:23 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:25:23 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:25:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:25:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:25:25 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:25:25 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:25:25 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:25:25 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:25:25 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:25:25 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:25:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:25:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:25:25 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:25:25 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:25:25 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:25:25 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:25:25 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:25:25 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:25:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:25:25 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:25:25 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:25:25 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:25:25 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:25:25 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:25:25 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:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:25:25 INFO - no previously-included directories found matching 'docs/_build' 15:25:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:25:26 INFO - Running setup.py install for pep8 15:25:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:25:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:25:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:25:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:25:26 INFO - no previously-included directories found matching 'docs/_build' 15:25:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:25:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:25:26 INFO - Cleaning up... 15:25:26 INFO - Return code: 0 15:25:26 INFO - Running post-action listener: _resource_record_post_action 15:25:26 INFO - Running post-action listener: _start_resource_monitoring 15:25:26 INFO - Starting resource monitoring. 15:25:26 INFO - ##### 15:25:26 INFO - ##### Running install step. 15:25:26 INFO - ##### 15:25:26 INFO - Running pre-action listener: _resource_record_pre_action 15:25:26 INFO - Running main action method: install 15:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:26 INFO - Reading from file tmpfile_stdout 15:25:26 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:26 INFO - Reading from file tmpfile_stdout 15:25:26 INFO - Output received: 15:25:26 INFO - Usage: mozinstall [options] installer 15:25:26 INFO - Options: 15:25:26 INFO - -h, --help show this help message and exit 15:25:26 INFO - -d DEST, --destination=DEST 15:25:26 INFO - Directory to install application into. [default: 15:25:26 INFO - "/builds/slave/test"] 15:25:26 INFO - --app=APP Application being installed. [default: firefox] 15:25:26 INFO - mkdir: /builds/slave/test/build/application 15:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:25:39 INFO - Reading from file tmpfile_stdout 15:25:39 INFO - Output received: 15:25:39 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:39 INFO - Running post-action listener: _resource_record_post_action 15:25:39 INFO - ##### 15:25:39 INFO - ##### Running run-tests step. 15:25:39 INFO - ##### 15:25:39 INFO - Running pre-action listener: _resource_record_pre_action 15:25:39 INFO - Running main action method: run_tests 15:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:39 INFO - Python 2.7.3 15:25:39 INFO - Return code: 0 15:25:39 INFO - grabbing minidump binary from tooltool 15:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:39 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 0x151c640>, '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 0x151d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151d9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:39 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:25:39 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:25:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:39 INFO - Return code: 0 15:25:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:25:40 INFO - Return code: 0 15:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:25:40 INFO - Using env: {'DISPLAY': ':0', 15:25:40 INFO - 'HOME': '/home/cltbld', 15:25:40 INFO - 'LANG': 'en_US.UTF-8', 15:25:40 INFO - 'LANGUAGE': 'en_US:en', 15:25:40 INFO - 'LOGNAME': 'cltbld', 15:25:40 INFO - 'MAIL': '/var/mail/cltbld', 15:25:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:40 INFO - 'MOZ_NO_REMOTE': '1', 15:25:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:40 INFO - 'NO_EM_RESTART': '1', 15:25:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:40 INFO - 'PWD': '/builds/slave/test', 15:25:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:40 INFO - 'SHELL': '/bin/bash', 15:25:40 INFO - 'SHLVL': '1', 15:25:40 INFO - 'TERM': 'linux', 15:25:40 INFO - 'TMOUT': '86400', 15:25:40 INFO - 'USER': 'cltbld', 15:25:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687', 15:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:40 INFO - '_': '/tools/buildbot/bin/python'} 15:25:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:25:40 INFO - mozversion application_buildid: 20160630122427 15:25:40 INFO - mozversion application_changeset: 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 15:25:40 INFO - mozversion application_display_name: Firefox 15:25:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:40 INFO - mozversion application_name: Firefox 15:25:40 INFO - mozversion application_remotingname: firefox 15:25:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:25:40 INFO - mozversion application_vendor: Mozilla 15:25:40 INFO - mozversion application_version: 48.0 15:25:40 INFO - mozversion platform_buildid: 20160630122427 15:25:40 INFO - mozversion platform_changeset: 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 15:25:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:25:40 INFO - mozversion platform_version: 48.0 15:25:40 INFO - using testdate: 1467325540 15:25:40 INFO - actual date: 1467325540 15:25:40 INFO - starting webserver on 'localhost:56032' 15:25:40 INFO - SUITE-START | Running 2 tests 15:25:40 INFO - TEST-START | dromaeo_css 15:25:40 INFO - operating with platform_type : linux_ 15:25:40 INFO - Initialising browser for dromaeo_css test... 15:25:41 INFO - TEST-INFO | started process 3308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS42U2w/profile http://localhost:56032/getInfo.html) 15:25:46 INFO - PROCESS | 3308 | __metrics Screen width/height:1600/1200 15:25:46 INFO - PROCESS | 3308 | colorDepth:24 15:25:46 INFO - PROCESS | 3308 | Browser inner width/height: 1024/697 15:25:46 INFO - PROCESS | 3308 | __metrics 15:25:48 ERROR - PROCESS | 3308 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:25:49 INFO - TEST-INFO | 3308: exit 0 15:25:49 INFO - Browser initialized. 15:25:49 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:49 INFO - TEST-INFO | started process 3398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS42U2w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:26:01 INFO - PROCESS | 3398 | RSS: Main: 140308480 15:26:01 INFO - PROCESS | 3398 | 15:26:52 INFO - PROCESS | 3398 | 1467325612339 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:29:00 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:56032/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56032/tests/dromaeo/cssquery-ext.html) 15:29:01 INFO - PROCESS | 3398 | RSS: Main: 249659392 15:29:01 INFO - PROCESS | 3398 | 15:32:03 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:56032/tests/dromaeo/cssquery-ext.html (next: http://localhost:56032/tests/dromaeo/cssquery-jquery.html) 15:32:03 INFO - PROCESS | 3398 | RSS: Main: 228405248 15:32:03 INFO - PROCESS | 3398 | 15:35:05 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:56032/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56032/tests/dromaeo/cssquery-mootools.html) 15:35:06 INFO - PROCESS | 3398 | RSS: Main: 219574272 15:35:06 INFO - PROCESS | 3398 | 15:38:08 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:56032/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56032/tests/dromaeo/cssquery-prototype.html) 15:38:08 INFO - PROCESS | 3398 | RSS: Main: 216342528 15:38:08 INFO - PROCESS | 3398 | 15:41:11 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:56032/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56032/tests/dromaeo/cssquery-yui.html) 15:41:11 INFO - PROCESS | 3398 | RSS: Main: 215576576 15:41:11 INFO - PROCESS | 3398 | 15:44:14 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:56032/tests/dromaeo/cssquery-yui.html (next: http://localhost:56032/tests/dromaeo/cssquery-dojo.html) 15:44:14 INFO - PROCESS | 3398 | RSS: Main: 251047936 15:44:14 INFO - PROCESS | 3398 | 15:44:14 INFO - PROCESS | 3398 | __start_tp_report 15:44:14 INFO - PROCESS | 3398 | _x_x_mozilla_page_load 15:44:14 INFO - PROCESS | 3398 | _x_x_mozilla_page_load_details 15:44:14 INFO - PROCESS | 3398 | |i|pagename|runs| 15:44:14 INFO - PROCESS | 3398 | |0;dojo.html;3310.271740217152;3351.095204294842;3365.999999999999;3377.814220217887;3403.421418358879;5550.944490555094;5565.443455654433;5568.220449137119;5568.638038527492;5570.108782594785;5564.8330550083565;5565.2486914266665;5574.581906357029;5583.4974852263385;5644.181593668915;5025.3718285214345;5036.722980236076;5039.874003149914;5114.437411884708;5163.096458119814;5047.949520504784;5070.84787456375;5145.485451454862;5149.613778966574;5151.716655583941;4983.451820299764;5086.847394578169;5159.432462429129;5186.5591424728755;5199.012187684347;5148.613853960968;5154.896902061956;5166.405863325728;5173.30160428343;5194.324737784102;4915.5084491550915;4937.333459982929;5001.924971125436;5074.162763144113;5092.337996060525;5444.646098003617;5447.264619276387;5461.317335333044;5483.479069488392;5486.094794358926;6002.099685047234;6035.547333949971;6039.033754599243;6044.455998960115;6049.516038716936;5954.5534084943365;6019.879602407971;6036.6076205046975;6044.123602077674;6055.152278680988;5620.1288800236025;5634.577406694514;5666.829995100154;5677.77288908439;5685.0619647758485;5974.492168165668;6208.875822483525;6212.254529456494;6237.282712488031;6237.594556353823;5890.410958904161;5972.522198224132;5975.760969561169;5985.191999080155;6002.279726432768;5976.282846058414;5990.940090599125;5991.310999235144;5999.070144127667;6013.849653758603;5792.304923409218;5912.9113063304085;5953.851153721192;5973.462388385066;5986.760529578768;5943.167956486095;5959.374265702038;5963.19496867926;5975.073863551156;6004.579679422399;4554.203014472454;4555.40779698637;4556.270996640522;4557.498675145731;4577.8397756078375;3990.86031988879;4015.7791321477016;4049.805307434314;4079.653229475528;4114.238865809834;5664.433556644302;5692.288463942007;5723.971380143156;5735.397783232784;5754.971225143848;6004.189434426384;6013.609115407485;6018.097285407224;6021.939780602225;6025.849353766191;5516.889662206733;5664.461876121762;5715.457031581993;5715.5713321500225;5824.854378640568;4904.558589726942;4905.828296009622;4906.955916011572;4915.705057696549;4925.605951523869;6298.023806309938;6306;6309.242890853127;6324;6325.272593651697;5859.970700146472;5968.074948383008;6024.457798798042;6083.300420451705;6101.145839582373;6322.304546499973;6365.108884756045;6396.008618664115;6402;6415.166028416276;5950.434708702666;5956.731947062306;5958.433948774859;5964.821055368346;5977.760889564543;5869.706514674163;6029.969850150721;6097.298810636834;6123.7244324006415;6129.509639228941;5888.205092312483;5918.704064796829;5923.052311630118;5925.288965324189;5939.049752039653;5738.770449182153;5857.47282744555;5883.882322353615;5920.319163296276;5923.229980102559;5761.078227483583;5809.564282678901;5811.709414529341;5850.765969361348;5860.560457965585;5793.304803423616;5801.042827933344;5816.302043754777;5823.068309070529;5838.416158384128;5573.414791446839;5690.71546422669;5692.601517893708;5740.741666625096;5768.538516918553 15:44:14 INFO - PROCESS | 3398 | |1;ext.html;659.5416185750902;684.4182444921817;686.8763622547939;738.4719925253443;749.4903465643362;32911.67088329116;33676.158096047584;40000.99999999996;40641.187176256455;40659;42950.14099718004;43513.12973740531;43531.56468435322;43573.34639980395;43619.56380436195;8813.471191728517;8966.282697384226;8996.8650470243;8998.820023599525;9004.504752238625;8808.603612837438;8929.464232146092;8931.062238464965;8940.418872773249;8945.239654629331;8990.910090899106;9291.907080929172;9292.53537323131;9304.627814887397;9307.488088155149;9181.58682859273;9246.398984066082;9258.814823703487;9259.305552083588;9266.536673166349;9066.229370503515;9162.679306224316;9172.954135229347;9176.587053582605;9178.173964343241;44485.110297794185;45072;45101.77449112766;45101.77449112766;45147.54852451499;3655.1958569114754;3717.739758216926;3784.2431513697097;3912.960870391288;4414.4923333816705;33420.49869251963;33821.83089084563;34045.829770850985;34146;35224.11939701528;4419.0940857124215;4426.380306757057;4511.526289739563;4522.9547704522865;4525.773711314454;243030;244373;244629;244837.99999999822;245325;39348.213035739696;64318.678406607665;64978.35021649818;65179;65211.34788652148;38059.61940380616;38174.618253817665;38183.427248591295;38211;38217;16209.108499032667;16416.589585260226;16423.096729679743;16436.83563164353;16440.424585139463;14820;14832.703345933021;14945.402183912522;14962.102273863604;14962.625934351729;9358.625654973861;9370.62517499306;9436.433813971184;9454.43273403598;9478.241740660731;3501.614822369588;3566.411542095525;3568.7145028397667;3586.103474131467;3640.417533194729;1123.8707548631849;1162.6802629276847;1185.525789684116;1190.0598527163618;1202.3687564028955;33828.13945233036;34653.30693386118;34694.30611387758;34705.30589388248;35046;1243.4715246020405;1248.3321423038813;1267.9809802852965;1311.0953442124903;1333.4199623163954;18149.092545372678;18257.543561411072;18355.265789368543;18461.907690461463;18474.44576662702;494940;498999;502324;503879;507044;63546;64434.0334894977;64504;64514.6774266135;64526.6773666138;1421.587739555538;1451.1148199598238;1496.1546726099718;1503.5714821275883;1503.9398424063133;30749.385012300078;31192.532112017885;33381;33393.996360218465;33944;50935;51153.488465114875;51504.22743658923;51532.74233628958;51575.74212128916;315669;315716;317225;317654;426455;31022.22444438907;31242;31248.843755781076;31269.530957036117;31343.21641958969;44199.558004419545;44587.108257834014;44629.33056004097;45654;45712.31431528463;37197.44203836891;37633.81183094067;38223.617763822;38380.616193837704;38740.80629596834;37309;37606.435903462014;39780.20439591134;40788.79605601953;40890.79554602208;42332.153356932075;43283.35074973815;43601.56398435975;43628.56371436245;43752.124957501306;35939;36861.44707829331;36978.815105924295;37224.441633374976;37800.43299350457;28846.423071538873;28929.56605650875;28936.421271574873;29105.563416549194;29205.415891681623 15:44:14 INFO - PROCESS | 3398 | |2;jquery.html;435.90845922356306;436.1212157502631;440.24937481593884;447.69780398231194;450.5778611446068;18976.43070707879;19081.71377429338;19519.219231230752;21072.15711371543;21123;20038.899805500987;20105.798942010577;20368.592628147464;20425.795742042574;20457.897710511428;4969.900601987958;5209.661372010826;5214.843554693365;5217.713025783581;5218.32161818963;3929.4302326162688;4421.960839202785;5117.872053198681;5190.558802501791;6440.484761219114;6386.105945167657;6412.358764123597;6420.486361091102;6423.678816059201;6427.196600424947;5807;5880.794172203995;5886.882262354772;6362.5546211765195;6367.267764207106;5823.126531020339;5825;5825.970870145622;5832.766689332421;5854.268216472941;14511.782323265159;22689.432764180863;23668.289951301318;23734.287971360885;23864;2248.5615305015526;2346.8005219556358;2391.497785465054;2436.3665446983737;2505.649209110708;10463.633772817915;10478.895211047944;10737.194710396752;10965.451727413678;14399.496017639332;1873.784514780804;1922.144645632694;1936.06101040995;2029.573789504206;2122.6922096296107;53392.73303633496;53722.73138634321;53831.19253211205;59527.70236148835;82745.58627206825;11414.37220952839;11752.647420577225;11802.46888890002;11881.940590296994;11975.880241197476;16772.58068548296;16885.83114168867;16897.408590699266;16922;16922;8446.662133514714;8842.159994800484;8862.468251904906;8960.372773905765;9012.27901767857;8776.78058048554;8809.823803524021;8834.911650883409;8899.243564296978;8918.509481978554;4977.701337919736;5188.066148093304;5201.141811601119;5207.427183009866;5240.868978275497;2065.8450616203845;2067.7725450200464;2070.8653937494314;2087.6137914485566;2114.6831961413372;995.328153496387;1025.5846382215216;1070.2240875365453;1083.3554035348955;1146.2721172055806;17266.740998885027;19972.800271997385;20280.594388112157;20313.187472500933;20455.8977205113;1084.0352086642895;1102.9558817647364;1116.1294190531398;1125.6848082536903;1137.4597066393396;11155.776884462266;11425.2002359834;11443.485043173077;11499.137564682682;11537.423128843524;497264;500367;502371;504443;507296;100884;101724;102539;102917;103218;996.3125443444001;1056.4400867540062;1118.552578968403;1141.7659379827116;1156.3524426321287;17115.400960966803;17187.57031074183;17382.304707811545;17491.21289541999;17502.387416440364;38321.80839095786;38517.422238667;38579.80710096432;39109;39318.2136357277;63361.68319158375;64602.676986614766;64887.67556162189;65360.346396535424;65472.67263663651;9308.813823723623;9310.860337094813;9330.160285574331;9472.052794720474;9495.43027418357;12872.22766634005;13069.803952940903;14008.789868151782;14046.508372207332;14131;11721.941390292994;11746.353950532803;11758.823617645914;11857;12155.392230388623;11479.966802987772;11514.53941842317;11647.59233426826;11740.354280514654;11869.525218991144;12058.216215945935;12544.498220071095;12697.238165710087;12912.418941147484;12916.677083072998;9106.180443760093;9280;9403.4828084456;9412.67055653049;9471.715848524555;8976.371653984159;12331.568395106127;12372.690682733004;12391.256524608552;12406.379681015733 15:44:14 INFO - PROCESS | 3398 | |3;mootools.html;1390.3187438155308;1507.5175943698014;1529.9694006119878;1711.4865540337903;1886.349209522714;7383.741569045078;8098.919010809897;8346.374021948355;8374.120717324684;8386.20331068549;8332.500049997005;8334.333253339733;8419.284360829322;8422.747317580466;8434.451760635555;2464.950700985979;2495.388629785696;2495.9376015599573;2495.987520062397;2497.625356196576;2417.226487523993;2481.4788894332214;2496.3759060234943;2499.250224932522;2514.8365356251784;2482.577961746498;2488.14159115105;2497.1759319424546;2502.674652295208;2502.737212592679;2421.358340039882;2451.8283720139507;2456.299954512955;2459.938501537458;2462.212092130519;2335.74306826249;2355.470019245673;2361.5276944611146;2362.65741467488;2494.9750502494926;8232.259096681328;8509.82980340396;8573.22840944318;8578.785530361729;8581.656733730642;5420.810271640474;5463.836084917459;5514.420985796514;5525.889482210374;5526.143447765603;3351.279474912881;3371.848266827974;3399.4673967894078;3429.639887811769;3442.2599141184514;1078.735709751108;1084.6474895658864;1099.367863478503;1138.1691365303293;1154.2382027861572;11554.653360399201;11741.530338786439;12174;12176.634700958897;12197.695057623541;4668.486466488684;4719.551642593948;4735.195016847144;4746.762661866962;4800.399950006249;9643;9745.56144973478;9751.804963900682;9754.414735115915;9763.853542196874;5462;5539;5547.1679248113105;5557.833265002057;5572.3870374258795;4412.84555040572;4913.410390753133;4995.475475075064;5018.949810501921;5045.672031317952;3942.3639189735936;3977.622125898035;4023.4970628671417;4042.191561687674;4079.755214687128;1249.425264378378;1272.9872701273055;1282.8075788631593;1283.230061962815;1297.8896793772446;975.5707488705089;979.8285300072602;982.037603148918;999.3753903810118;1015.619142821442;5679.403662615448;5691.516221121251;5691.9146212806845;5764.164196191528;5826.300843898674;463.0992719161199;469.66419010407725;470.5177193376816;476.20949224287517;489.9853004409873;3687.4100143976834;3706.4625629283605;3714.851405943732;3723.94414083789;3726.273376691519;10365.792684146425;10698.51856666452;10866.945665271624;10889.727756805985;10922.29005114665;10567.947160264303;10723.14214862809;10738.570457181626;10771.353718776898;10793.892061079447;8281.54451505173;8350.66597336112;8355.874661880076;8362.790930226914;8365.07984121746;5517.475839795213;5534.280543529316;5566.304211973504;5637.3235211774845;5673.8297851064535;9210.585523651585;9363.344565880596;9423.38747981379;9515.76210594713;9523.476208808583;9056.864147037932;9399.248060155307;9519.666811661835;9601.423914565148;9611.855822162814;6755.290694477206;7135.357817796424;7234.385077268281;7294.63526823646;7414.332710055905;7964.163762805054;7987.321077708228;8006.799830004296;8035.276825085771;8036.075851277178;7134.429245660439;7373.77878663641;7387.556746595222;7465.365443937326;7466.066741657293;7401.089883127705;7417.517861338995;7481.812954676177;7530.209328020698;7540.54756714577;6913.1358580177475;6945.0971373721095;6979.616121113185;6988.440924725908;7006.439484841098;4877.3903262092235;5065.924011139762;5096.821611243588;5148.2020286855595;5167.767450464813;4925.655204135676;4994.4755800640405;5113.565346945551;5195.012947539955;5221.321228240305 15:44:14 INFO - PROCESS | 3398 | |4;prototype.html;373.19203923505614;373.62264113245647;377.86396897117044;378.1095520050281;378.9355809512384;6089.29973053099;6175.228096487939;6208.037754148103;6233.812985610428;6246.156768836211;5941.910871336933;6159.846003849895;6160.84597885052;6161.137440758297;6166.568340216176;4680.040591678706;4728.385309909707;4739.786709598076;4750.192467280571;4757.310190022445;4655.88360290992;4666.8366607168755;4749.76251187441;4752.59602933751;4767.451743049542;4551.203539380595;4714.5756881880625;4748.3589715388325;4775.426948766153;4778.139934811733;4639.443266807971;4672.11229866326;4674.929876051862;4759.071980963713;4762.404699412574;4207.284761590537;4222.535521092677;4224.028473451123;4231.386448964883;4235.23765722173;5980.491658209057;5992.43071908168;5993.101034844764;6007.15899774032;6009.75960961561;5560.471755183251;5568.693721845297;5573.41479144688;5592.972035139839;5594.916076258859;6474.6762661866715;6576.309487503839;6646.468282537386;6647.1026411434805;6653.035309880041;4679.859604211845;4682.555157260055;4692.718436893797;4695.248760198352;4698.365720627706;6832.555883867582;6869.931300687029;6875.759348422781;6877.58734475928;6882.7591034314055;4795.472498025214;4800.543948324904;4800.66395352329;4805.4233491980485;4805.423349198119;4864.416270047546;4865.343178670905;4866.683665561727;4870.05034018363;4871.80512779492;5558.638688485235;5561.694106824082;5565.1374037024325;5572.665640061528;5577.6932268724795;6469.191351081115;6621.33786621334;6622.503312251601;6627.768028119089;6637.900431493532;1708.1630001299275;1723.7069698151345;1733.514615907548;1734.6270551831417;1735.479356193137;1103.3545375954996;1130.8247221680654;1137.3176094343328;1155.8555180602425;1160.193665402554;6313.242410910629;6426.935730642727;6471.6764161791725;6492.577982431127;6499.252585952676;6867.587944723333;6873.725050998004;6875;6885.586864788129;6889.138857642794;6477.4170324671;6484.967575162188;6485.319041500669;6488.837779055467;6490.675466226669;3654.14127679995;3677.6138505456543;3690.372636651722;3691.686206672463;3697.6302369762807;7039.084918960605;7180.174279957767;7196.820079498055;7211.098612673416;7213.278672132849;6975.79072627822;6990.475714321345;6992.300769922967;6993.860122797516;6998.7900362988175;7157;7172.569645821268;7176.569405835667;7186.748463803847;7187.101612298358;6841.589504629738;6849.041134241111;6849.212340580897;6859.691313890787;6861.519693621399;6571.671416429255;6745.392914637509;6753.561018533779;6761.661916904037;6763.5941843489545;7115.857682846417;7163.176234733072;7165.820854478679;7166.462515311268;7183;4797.2564252540915;4798.880027999188;4803.615710743202;4805.471398146271;4806.639502037291;6815.556988795713;6831.89752153728;6836.589804611739;6836.863262734618;6856;6453.677316134268;6614.801555953329;6615;6625.17185351831;6638.701258443285;6534.542582019213;6576.079348891255;6580.703868325841;6583.144191255106;6597.60414375139;6481.4814814815645;6484.286728459771;6487.3188315226225;6491.221053473613;6492.740290388331;6624.768133115318;6634.933650663625;6645.900311495235;6648.235452922976;6658.63377514222;6334.714937827716;6487.643179625166;6491.772787952399;6496.512761542808;6507.6746162692625 15:44:14 INFO - PROCESS | 3398 | |5;yui.html;911.2209061252627;916.7341470973419;920.1626519866918;930.7440453875183;941.7692665297003;13657.590272291822;13940.302984850743;14053.789193162085;14071.29643517824;14079.718405631882;13211.405486753096;13211.93394033031;13286.468541258362;13797.103188292755;13835.654108647288;896.932730045246;908.4957848394139;909.172652885874;915.555955361649;916.2395211974045;886.4016788667656;890.679355432044;891.3671293381707;894.2354287084546;894.3694695239873;946.6213514594149;953.9904600953971;960.9471479068649;961.3462845265217;961.4808003678005;943.4197968249512;943.688582767685;944.2398868910524;945.7777422305787;951.1107114847605;689.9862002759967;692.0829900381964;694.5832500499711;695.9304069593051;698.2354322017383;13849.238291893942;13862.93068534661;13943;13955.651108722263;15135.091894486366;13573.107710009248;14180.929095354457;14289.785653215211;14518.854811451962;14563.70872582553;11181.776364472666;11581.710457238636;11690.47392867323;11973;12265.57070502528;3927.293087244295;3940.704447166474;3967.940480892789;3974.7813870237123;4047.150098479323;55314.72342638261;55453.722731386086;55456.72271638616;55492;56508;11502.712432189262;11660.416979151178;11730.88269117298;11852.585159519376;12046.638600841989;20929.372118836458;20931;20936.162553497994;20979.370618881458;20999.8950005249;8771.429857059271;8789.736307910773;8934.821303573892;9146.95426522863;9255.398399104037;4925.8029678812445;4952.678075925053;4965.950340496621;5128.358955130609;5143.151380022255;3656;3694.9630503695157;3701.241245544657;3706.2031663192543;3709.9443508347395;671.1476424940298;676.2865177237962;681.8090934538337;686.4954258619911;689.1764341611826;715.9463040272001;792.3581898662102;824.7938015496126;836.506461187902;849.218718778725;9432.481213533321;9874.061964113398;9947.950260248652;10001.689474573448;10022.098011178883;742.7511783552462;751.3538357012965;753.8266198774313;768.9653965571563;771.2095102519962;4519.412476378116;4629.537046295343;4647.37260469839;4697.78859951303;4717.339572459859;65408.345916540224;65766.67116664386;66516.33483665198;67903.32096679069;68200;45807.312890306675;59709.40290597038;59956;60177.097343539885;65318;51655.7417212919;52086.739566302684;52159.217611735854;53645.73177134089;54510.45489545054;8889.710991906266;9034.593443295198;9266.53667316618;9330.95334523323;9350.766230844283;41167;41214;41356.379654304605;41995.37006944959;42994.57005429906;51104.233436497736;52364.476355237486;52531.21203181879;54884;55153.448465516434;12827.358632068546;13691.452341906212;13966.79049814274;14037.719245614826;14513.419463221353;12928.353582321035;13278.925105747698;13468.93265533666;13604.115732477358;13775.931120344734;12874.935625321814;13196.60410187696;13295.335233238493;13357.13178643385;13415.597532074053;12560;12560.811587826007;12675.746485070431;12738.808917866054;12784.169029013085;12291.139620226499;12627.431765570755;12972;12981.935090324489;13185.53850615224;10291.7427064321;10329.9483502585;10345.637902673672;10619.097376722755;10687.25189236777;9712.3201375903;10591.311564748266;10708.839367409651;10805;10828.675139745821 15:44:14 INFO - PROCESS | 3398 | __end_tp_report 15:44:14 INFO - PROCESS | 3398 | __start_cc_report 15:44:14 INFO - PROCESS | 3398 | _x_x_mozilla_cycle_collect,827 15:44:14 INFO - PROCESS | 3398 | __end_cc_report 15:44:14 INFO - PROCESS | 3398 | __startTimestamp1467326654248__endTimestamp 15:44:14 INFO - PROCESS | 3398 | 15:44:14 INFO - PROCESS | 3398 | ------- Summary: start ------- 15:44:14 INFO - PROCESS | 3398 | Number of tests: 6 15:44:14 INFO - PROCESS | 3398 | 15:44:14 INFO - PROCESS | 3398 | [#0] dojo.html Cycles:165 Average:5574.64 Median:5793.30 stddev:644.88 (11.1%) stddev-sans-first:621.91 15:44:14 INFO - PROCESS | 3398 | Values: 3310.3 3351.1 3366.0 3377.8 3403.4 5550.9 5565.4 5568.2 5568.6 5570.1 5564.8 5565.2 5574.6 5583.5 5644.2 5025.4 5036.7 5039.9 5114.4 5163.1 5047.9 5070.8 5145.5 5149.6 5151.7 4983.5 5086.8 5159.4 5186.6 5199.0 5148.6 5154.9 5166.4 5173.3 5194.3 4915.5 4937.3 5001.9 5074.2 5092.3 5444.6 5447.3 5461.3 5483.5 5486.1 6002.1 6035.5 6039.0 6044.5 6049.5 5954.6 6019.9 6036.6 6044.1 6055.2 5620.1 5634.6 5666.8 5677.8 5685.1 5974.5 6208.9 6212.3 6237.3 6237.6 5890.4 5972.5 5975.8 5985.2 6002.3 5976.3 5990.9 5991.3 5999.1 6013.8 5792.3 5912.9 5953.9 5973.5 5986.8 5943.2 5959.4 5963.2 5975.1 6004.6 4554.2 4555.4 4556.3 4557.5 4577.8 3990.9 4015.8 4049.8 4079.7 4114.2 5664.4 5692.3 5724.0 5735.4 5755.0 6004.2 6013.6 6018.1 6021.9 6025.8 5516.9 5664.5 5715.5 5715.6 5824.9 4904.6 4905.8 4907.0 4915.7 4925.6 6298.0 6306.0 6309.2 6324.0 6325.3 5860.0 5968.1 6024.5 6083.3 6101.1 6322.3 6365.1 6396.0 6402.0 6415.2 5950.4 5956.7 5958.4 5964.8 5977.8 5869.7 6030.0 6097.3 6123.7 6129.5 5888.2 5918.7 5923.1 5925.3 5939.0 5738.8 5857.5 5883.9 5920.3 5923.2 5761.1 5809.6 5811.7 5850.8 5860.6 5793.3 5801.0 5816.3 5823.1 5838.4 5573.4 5690.7 5692.6 5740.7 5768.5 15:44:14 INFO - PROCESS | 3398 | 15:44:14 INFO - PROCESS | 3398 | [#1] ext.html Cycles:180 Average:53033.21 Median:21326.88 stddev:100087.13 (469.3%) stddev-sans-first:100290.65 15:44:14 INFO - PROCESS | 3398 | Values: 659.5 684.4 686.9 738.5 749.5 32911.7 33676.2 40001.0 40641.2 40659.0 42950.1 43513.1 43531.6 43573.3 43619.6 8813.5 8966.3 8996.9 8998.8 9004.5 8808.6 8929.5 8931.1 8940.4 8945.2 8990.9 9291.9 9292.5 9304.6 9307.5 9181.6 9246.4 9258.8 9259.3 9266.5 9066.2 9162.7 9173.0 9176.6 9178.2 44485.1 45072.0 45101.8 45101.8 45147.5 3655.2 3717.7 3784.2 3913.0 4414.5 33420.5 33821.8 34045.8 34146.0 35224.1 4419.1 4426.4 4511.5 4523.0 4525.8 243030.0 244373.0 244629.0 244838.0 245325.0 39348.2 64318.7 64978.4 65179.0 65211.3 38059.6 38174.6 38183.4 38211.0 38217.0 16209.1 16416.6 16423.1 16436.8 16440.4 14820.0 14832.7 14945.4 14962.1 14962.6 9358.6 9370.6 9436.4 9454.4 9478.2 3501.6 3566.4 3568.7 3586.1 3640.4 1123.9 1162.7 1185.5 1190.1 1202.4 33828.1 34653.3 34694.3 34705.3 35046.0 1243.5 1248.3 1268.0 1311.1 1333.4 18149.1 18257.5 18355.3 18461.9 18474.4 494940.0 498999.0 502324.0 503879.0 507044.0 63546.0 64434.0 64504.0 64514.7 64526.7 1421.6 1451.1 1496.2 1503.6 1503.9 30749.4 31192.5 33381.0 33394.0 33944.0 50935.0 51153.5 51504.2 51532.7 51575.7 315669.0 315716.0 317225.0 317654.0 426455.0 31022.2 31242.0 31248.8 31269.5 31343.2 44199.6 44587.1 44629.3 45654.0 45712.3 37197.4 37633.8 38223.6 38380.6 38740.8 37309.0 37606.4 39780.2 40788.8 40890.8 42332.2 43283.4 43601.6 43628.6 43752.1 35939.0 36861.4 36978.8 37224.4 37800.4 28846.4 28929.6 28936.4 29105.6 29205.4 15:44:14 INFO - PROCESS | 3398 | 15:44:14 INFO - PROCESS | 3398 | [#2] jquery.html Cycles:180 Average:29466.46 Median:11618.84 stddev:82731.58 (712.0%) stddev-sans-first:82934.95 15:44:14 INFO - PROCESS | 3398 | Values: 435.9 436.1 440.2 447.7 450.6 18976.4 19081.7 19519.2 21072.2 21123.0 20038.9 20105.8 20368.6 20425.8 20457.9 4969.9 5209.7 5214.8 5217.7 5218.3 3929.4 4422.0 5117.9 5190.6 6440.5 6386.1 6412.4 6420.5 6423.7 6427.2 5807.0 5880.8 5886.9 6362.6 6367.3 5823.1 5825.0 5826.0 5832.8 5854.3 14511.8 22689.4 23668.3 23734.3 23864.0 2248.6 2346.8 2391.5 2436.4 2505.6 10463.6 10478.9 10737.2 10965.5 14399.5 1873.8 1922.1 1936.1 2029.6 2122.7 53392.7 53722.7 53831.2 59527.7 82745.6 11414.4 11752.6 11802.5 11881.9 11975.9 16772.6 16885.8 16897.4 16922.0 16922.0 8446.7 8842.2 8862.5 8960.4 9012.3 8776.8 8809.8 8834.9 8899.2 8918.5 4977.7 5188.1 5201.1 5207.4 5240.9 2065.8 2067.8 2070.9 2087.6 2114.7 995.3 1025.6 1070.2 1083.4 1146.3 17266.7 19972.8 20280.6 20313.2 20455.9 1084.0 1103.0 1116.1 1125.7 1137.5 11155.8 11425.2 11443.5 11499.1 11537.4 497264.0 500367.0 502371.0 504443.0 507296.0 100884.0 101724.0 102539.0 102917.0 103218.0 996.3 1056.4 1118.6 1141.8 1156.4 17115.4 17187.6 17382.3 17491.2 17502.4 38321.8 38517.4 38579.8 39109.0 39318.2 63361.7 64602.7 64887.7 65360.3 65472.7 9308.8 9310.9 9330.2 9472.1 9495.4 12872.2 13069.8 14008.8 14046.5 14131.0 11721.9 11746.4 11758.8 11857.0 12155.4 11480.0 11514.5 11647.6 11740.4 11869.5 12058.2 12544.5 12697.2 12912.4 12916.7 9106.2 9280.0 9403.5 9412.7 9471.7 8976.4 12331.6 12372.7 12391.3 12406.4 15:44:14 INFO - PROCESS | 3398 | 15:44:14 INFO - PROCESS | 3398 | [#3] mootools.html Cycles:180 Average:5648.13 Median:5105.19 stddev:3132.13 (61.4%) stddev-sans-first:3124.57 15:44:14 INFO - PROCESS | 3398 | Values: 1390.3 1507.5 1530.0 1711.5 1886.3 7383.7 8098.9 8346.4 8374.1 8386.2 8332.5 8334.3 8419.3 8422.7 8434.5 2465.0 2495.4 2495.9 2496.0 2497.6 2417.2 2481.5 2496.4 2499.3 2514.8 2482.6 2488.1 2497.2 2502.7 2502.7 2421.4 2451.8 2456.3 2459.9 2462.2 2335.7 2355.5 2361.5 2362.7 2495.0 8232.3 8509.8 8573.2 8578.8 8581.7 5420.8 5463.8 5514.4 5525.9 5526.1 3351.3 3371.8 3399.5 3429.6 3442.3 1078.7 1084.6 1099.4 1138.2 1154.2 11554.7 11741.5 12174.0 12176.6 12197.7 4668.5 4719.6 4735.2 4746.8 4800.4 9643.0 9745.6 9751.8 9754.4 9763.9 5462.0 5539.0 5547.2 5557.8 5572.4 4412.8 4913.4 4995.5 5018.9 5045.7 3942.4 3977.6 4023.5 4042.2 4079.8 1249.4 1273.0 1282.8 1283.2 1297.9 975.6 979.8 982.0 999.4 1015.6 5679.4 5691.5 5691.9 5764.2 5826.3 463.1 469.7 470.5 476.2 490.0 3687.4 3706.5 3714.9 3723.9 3726.3 10365.8 10698.5 10866.9 10889.7 10922.3 10567.9 10723.1 10738.6 10771.4 10793.9 8281.5 8350.7 8355.9 8362.8 8365.1 5517.5 5534.3 5566.3 5637.3 5673.8 9210.6 9363.3 9423.4 9515.8 9523.5 9056.9 9399.2 9519.7 9601.4 9611.9 6755.3 7135.4 7234.4 7294.6 7414.3 7964.2 7987.3 8006.8 8035.3 8036.1 7134.4 7373.8 7387.6 7465.4 7466.1 7401.1 7417.5 7481.8 7530.2 7540.5 6913.1 6945.1 6979.6 6988.4 7006.4 4877.4 5065.9 5096.8 5148.2 5167.8 4925.7 4994.5 5113.6 5195.0 5221.3 15:44:14 INFO - PROCESS | 3398 | 15:44:14 INFO - PROCESS | 3398 | [#4] prototype.html Cycles:180 Average:5559.68 Median:6323.98 stddev:1664.90 (26.3%) stddev-sans-first:1623.42 15:44:14 INFO - PROCESS | 3398 | Values: 373.2 373.6 377.9 378.1 378.9 6089.3 6175.2 6208.0 6233.8 6246.2 5941.9 6159.8 6160.8 6161.1 6166.6 4680.0 4728.4 4739.8 4750.2 4757.3 4655.9 4666.8 4749.8 4752.6 4767.5 4551.2 4714.6 4748.4 4775.4 4778.1 4639.4 4672.1 4674.9 4759.1 4762.4 4207.3 4222.5 4224.0 4231.4 4235.2 5980.5 5992.4 5993.1 6007.2 6009.8 5560.5 5568.7 5573.4 5593.0 5594.9 6474.7 6576.3 6646.5 6647.1 6653.0 4679.9 4682.6 4692.7 4695.2 4698.4 6832.6 6869.9 6875.8 6877.6 6882.8 4795.5 4800.5 4800.7 4805.4 4805.4 4864.4 4865.3 4866.7 4870.1 4871.8 5558.6 5561.7 5565.1 5572.7 5577.7 6469.2 6621.3 6622.5 6627.8 6637.9 1708.2 1723.7 1733.5 1734.6 1735.5 1103.4 1130.8 1137.3 1155.9 1160.2 6313.2 6426.9 6471.7 6492.6 6499.3 6867.6 6873.7 6875.0 6885.6 6889.1 6477.4 6485.0 6485.3 6488.8 6490.7 3654.1 3677.6 3690.4 3691.7 3697.6 7039.1 7180.2 7196.8 7211.1 7213.3 6975.8 6990.5 6992.3 6993.9 6998.8 7157.0 7172.6 7176.6 7186.7 7187.1 6841.6 6849.0 6849.2 6859.7 6861.5 6571.7 6745.4 6753.6 6761.7 6763.6 7115.9 7163.2 7165.8 7166.5 7183.0 4797.3 4798.9 4803.6 4805.5 4806.6 6815.6 6831.9 6836.6 6836.9 6856.0 6453.7 6614.8 6615.0 6625.2 6638.7 6534.5 6576.1 6580.7 6583.1 6597.6 6481.5 6484.3 6487.3 6491.2 6492.7 6624.8 6634.9 6645.9 6648.2 6658.6 6334.7 6487.6 6491.8 6496.5 6507.7 15:44:14 INFO - PROCESS | 3398 | 15:44:14 INFO - PROCESS | 3398 | [#5] yui.html Cycles:180 Average:15789.68 Median:4707.56 stddev:18540.04 (393.8%) stddev-sans-first:18558.38 15:44:14 INFO - PROCESS | 3398 | Values: 911.2 916.7 920.2 930.7 941.8 13657.6 13940.3 14053.8 14071.3 14079.7 13211.4 13211.9 13286.5 13797.1 13835.7 896.9 908.5 909.2 915.6 916.2 886.4 890.7 891.4 894.2 894.4 946.6 954.0 960.9 961.3 961.5 943.4 943.7 944.2 945.8 951.1 690.0 692.1 694.6 695.9 698.2 13849.2 13862.9 13943.0 13955.7 15135.1 13573.1 14180.9 14289.8 14518.9 14563.7 11181.8 11581.7 11690.5 11973.0 12265.6 3927.3 3940.7 3967.9 3974.8 4047.2 55314.7 55453.7 55456.7 55492.0 56508.0 11502.7 11660.4 11730.9 11852.6 12046.6 20929.4 20931.0 20936.2 20979.4 20999.9 8771.4 8789.7 8934.8 9147.0 9255.4 4925.8 4952.7 4966.0 5128.4 5143.2 3656.0 3695.0 3701.2 3706.2 3709.9 671.1 676.3 681.8 686.5 689.2 715.9 792.4 824.8 836.5 849.2 9432.5 9874.1 9948.0 10001.7 10022.1 742.8 751.4 753.8 769.0 771.2 4519.4 4629.5 4647.4 4697.8 4717.3 65408.3 65766.7 66516.3 67903.3 68200.0 45807.3 59709.4 59956.0 60177.1 65318.0 51655.7 52086.7 52159.2 53645.7 54510.5 8889.7 9034.6 9266.5 9331.0 9350.8 41167.0 41214.0 41356.4 41995.4 42994.6 51104.2 52364.5 52531.2 54884.0 55153.4 12827.4 13691.5 13966.8 14037.7 14513.4 12928.4 13278.9 13468.9 13604.1 13775.9 12874.9 13196.6 13295.3 13357.1 13415.6 12560.0 12560.8 12675.7 12738.8 12784.2 12291.1 12627.4 12972.0 12981.9 13185.5 10291.7 10329.9 10345.6 10619.1 10687.3 9712.3 10591.3 10708.8 10805.0 10828.7 15:44:14 INFO - PROCESS | 3398 | -------- Summary: end -------- 15:44:14 INFO - PROCESS | 3398 | 15:44:14 INFO - TEST-INFO | 3398: exit 0 15:44:14 INFO - TEST-OK | dromaeo_css | took 1113945ms 15:44:14 INFO - TEST-START | kraken 15:44:14 INFO - operating with platform_type : linux_ 15:44:14 INFO - Initialising browser for kraken test... 15:44:14 INFO - TEST-INFO | started process 3592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPKxBOF/profile http://localhost:56032/getInfo.html) 15:44:18 INFO - PROCESS | 3592 | __metrics Screen width/height:1600/1200 15:44:18 INFO - PROCESS | 3592 | colorDepth:24 15:44:18 INFO - PROCESS | 3592 | Browser inner width/height: 1024/697 15:44:18 INFO - PROCESS | 3592 | __metrics 15:44:19 ERROR - PROCESS | 3592 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:44:20 INFO - TEST-INFO | 3592: exit 0 15:44:20 INFO - Browser initialized. 15:44:20 INFO - Running cycle 1/1 for kraken test... 15:44:20 INFO - TEST-INFO | started process 3680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPKxBOF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:32 INFO - PROCESS | 3680 | RSS: Main: 140099584 15:44:32 INFO - PROCESS | 3680 | 15:44:35 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56032/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:35 INFO - PROCESS | 3680 | RSS: Main: 197193728 15:44:35 INFO - PROCESS | 3680 | 15:44:38 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56032/tests/kraken/driver.html?testName=audio-dft) 15:44:39 INFO - PROCESS | 3680 | RSS: Main: 184832000 15:44:39 INFO - PROCESS | 3680 | 15:44:41 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56032/tests/kraken/driver.html?testName=audio-fft) 15:44:42 INFO - PROCESS | 3680 | RSS: Main: 274505728 15:44:42 INFO - PROCESS | 3680 | 15:44:44 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56032/tests/kraken/driver.html?testName=audio-oscillator) 15:44:45 INFO - PROCESS | 3680 | RSS: Main: 180461568 15:44:45 INFO - PROCESS | 3680 | 15:44:47 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56032/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:47 INFO - PROCESS | 3680 | RSS: Main: 178384896 15:44:47 INFO - PROCESS | 3680 | 15:44:50 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56032/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:51 INFO - PROCESS | 3680 | RSS: Main: 213958656 15:44:51 INFO - PROCESS | 3680 | 15:44:54 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56032/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:55 INFO - PROCESS | 3680 | RSS: Main: 213086208 15:44:55 INFO - PROCESS | 3680 | 15:44:58 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56032/tests/kraken/driver.html?testName=json-parse-financial) 15:44:58 INFO - PROCESS | 3680 | RSS: Main: 213254144 15:44:58 INFO - PROCESS | 3680 | 15:45:00 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56032/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:45:00 INFO - PROCESS | 3680 | RSS: Main: 194031616 15:45:00 INFO - PROCESS | 3680 | 15:45:02 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56032/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:45:03 INFO - PROCESS | 3680 | RSS: Main: 197935104 15:45:03 INFO - PROCESS | 3680 | 15:45:05 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56032/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:45:05 INFO - PROCESS | 3680 | RSS: Main: 211030016 15:45:05 INFO - PROCESS | 3680 | 15:45:08 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:45:08 INFO - PROCESS | 3680 | RSS: Main: 217989120 15:45:08 INFO - PROCESS | 3680 | 15:45:11 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:45:12 INFO - PROCESS | 3680 | RSS: Main: 214409216 15:45:12 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:56032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56032/tests/kraken/driver.html?testName=ai-astar) 15:45:13 INFO - PROCESS | 3680 | RSS: Main: 274886656 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | __start_tp_report 15:45:13 INFO - PROCESS | 3680 | _x_x_mozilla_page_load 15:45:13 INFO - PROCESS | 3680 | _x_x_mozilla_page_load_details 15:45:13 INFO - PROCESS | 3680 | |i|pagename|runs| 15:45:13 INFO - PROCESS | 3680 | |0;ai-astar;111;112;112;111;111;112;105;110;112;110 15:45:13 INFO - PROCESS | 3680 | |1;audio-beat-detection;159;123;165;189;125;149;151;133;177;127 15:45:13 INFO - PROCESS | 3680 | |2;audio-dft;161;160;161;159;161;159;161;160;162;158 15:45:13 INFO - PROCESS | 3680 | |3;audio-fft;75;74;74;174;77;74;77;76;164;76 15:45:13 INFO - PROCESS | 3680 | |4;audio-oscillator;92;92;159;98;93;93;153;91;92;148 15:45:13 INFO - PROCESS | 3680 | |5;imaging-gaussian-blur;116;117;118;116;117;117;117;117;116;117 15:45:13 INFO - PROCESS | 3680 | |6;imaging-darkroom;146;145;145;145;145;146;145;145;145;145 15:45:13 INFO - PROCESS | 3680 | |7;imaging-desaturate;94;94;95;95;95;95;94;95;95;94 15:45:13 INFO - PROCESS | 3680 | |8;json-parse-financial;55;55;56;56;56;56;58;76;54;55 15:45:13 INFO - PROCESS | 3680 | |9;json-stringify-tinderbox;57;59;57;58;58;58;57;57;58;58 15:45:13 INFO - PROCESS | 3680 | |10;stanford-crypto-aes;72;73;72;72;74;74;74;74;75;73 15:45:13 INFO - PROCESS | 3680 | |11;stanford-crypto-ccm;115;116;117;119;119;114;114;113;128;114 15:45:13 INFO - PROCESS | 3680 | |12;stanford-crypto-pbkdf2;163;158;158;160;165;158;157;159;157;157 15:45:13 INFO - PROCESS | 3680 | |13;stanford-crypto-sha256-iterative;66;69;68;68;64;66;65;64;66;64 15:45:13 INFO - PROCESS | 3680 | __end_tp_report 15:45:13 INFO - PROCESS | 3680 | __start_cc_report 15:45:13 INFO - PROCESS | 3680 | _x_x_mozilla_cycle_collect,1563 15:45:13 INFO - PROCESS | 3680 | __end_cc_report 15:45:13 INFO - PROCESS | 3680 | __startTimestamp1467326713986__endTimestamp 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | ------- Summary: start ------- 15:45:13 INFO - PROCESS | 3680 | Number of tests: 14 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.12 (1.9%) stddev-sans-first:2.24 15:45:13 INFO - PROCESS | 3680 | Values: 111.0 112.0 112.0 111.0 111.0 112.0 105.0 110.0 112.0 110.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:155.00 stddev:22.92 (14.8%) stddev-sans-first:24.07 15:45:13 INFO - PROCESS | 3680 | Values: 159.0 123.0 165.0 189.0 125.0 149.0 151.0 133.0 177.0 127.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 15:45:13 INFO - PROCESS | 3680 | Values: 161.0 160.0 161.0 159.0 161.0 159.0 161.0 160.0 162.0 158.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.56 (52.4%) stddev-sans-first:41.35 15:45:13 INFO - PROCESS | 3680 | Values: 75.0 74.0 74.0 174.0 77.0 74.0 77.0 76.0 164.0 76.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:92.00 stddev:29.32 (31.9%) stddev-sans-first:30.27 15:45:13 INFO - PROCESS | 3680 | Values: 92.0 92.0 159.0 98.0 93.0 93.0 153.0 91.0 92.0 148.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 15:45:13 INFO - PROCESS | 3680 | Values: 116.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 15:45:13 INFO - PROCESS | 3680 | Values: 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:45:13 INFO - PROCESS | 3680 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:56.00 stddev:6.52 (11.6%) stddev-sans-first:6.84 15:45:13 INFO - PROCESS | 3680 | Values: 55.0 55.0 56.0 56.0 56.0 56.0 58.0 76.0 54.0 55.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 15:45:13 INFO - PROCESS | 3680 | Values: 57.0 59.0 57.0 58.0 58.0 58.0 57.0 57.0 58.0 58.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:74.00 stddev:1.06 (1.4%) stddev-sans-first:1.01 15:45:13 INFO - PROCESS | 3680 | Values: 72.0 73.0 72.0 72.0 74.0 74.0 74.0 74.0 75.0 73.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:116.50 stddev:4.43 (3.8%) stddev-sans-first:4.65 15:45:13 INFO - PROCESS | 3680 | Values: 115.0 116.0 117.0 119.0 119.0 114.0 114.0 113.0 128.0 114.0 15:45:13 INFO - PROCESS | 3680 | 15:45:13 INFO - PROCESS | 3680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:158.50 stddev:2.74 (1.7%) stddev-sans-first:2.54 15:45:14 INFO - PROCESS | 3680 | Values: 163.0 158.0 158.0 160.0 165.0 158.0 157.0 159.0 157.0 157.0 15:45:14 INFO - PROCESS | 3680 | 15:45:14 INFO - PROCESS | 3680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.83 (2.8%) stddev-sans-first:1.94 15:45:14 INFO - PROCESS | 3680 | Values: 66.0 69.0 68.0 68.0 64.0 66.0 65.0 64.0 66.0 64.0 15:45:14 INFO - PROCESS | 3680 | -------- Summary: end -------- 15:45:14 INFO - PROCESS | 3680 | 15:45:14 INFO - TEST-INFO | 3680: exit 0 15:45:14 INFO - TEST-OK | kraken | took 59982ms 15:45:14 INFO - SUITE-END | took 1173s 15:45:15 INFO - Completed test suite (00:19:34) 15:45:15 INFO - javascript benchmark 15:45:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.271740217152, 3351.095204294842, 3365.999999999999, 3377.814220217887, 3403.421418358879, 5550.944490555094, 5565.443455654433, 5568.220449137119, 5568.638038527492, 5570.108782594785, 5564.8330550083565, 5565.2486914266665, 5574.581906357029, 5583.4974852263385, 5644.181593668915, 5025.3718285214345, 5036.722980236076, 5039.874003149914, 5114.437411884708, 5163.096458119814, 5047.949520504784, 5070.84787456375, 5145.485451454862, 5149.613778966574, 5151.716655583941, 4983.451820299764, 5086.847394578169, 5159.432462429129, 5186.5591424728755, 5199.012187684347, 5148.613853960968, 5154.896902061956, 5166.405863325728, 5173.30160428343, 5194.324737784102, 4915.5084491550915, 4937.333459982929, 5001.924971125436, 5074.162763144113, 5092.337996060525, 5444.646098003617, 5447.264619276387, 5461.317335333044, 5483.479069488392, 5486.094794358926, 6002.099685047234, 6035.547333949971, 6039.033754599243, 6044.455998960115, 6049.516038716936, 5954.5534084943365, 6019.879602407971, 6036.6076205046975, 6044.123602077674, 6055.152278680988, 5620.1288800236025, 5634.577406694514, 5666.829995100154, 5677.77288908439, 5685.0619647758485, 5974.492168165668, 6208.875822483525, 6212.254529456494, 6237.282712488031, 6237.594556353823, 5890.410958904161, 5972.522198224132, 5975.760969561169, 5985.191999080155, 6002.279726432768, 5976.282846058414, 5990.940090599125, 5991.310999235144, 5999.070144127667, 6013.849653758603, 5792.304923409218, 5912.9113063304085, 5953.851153721192, 5973.462388385066, 5986.760529578768, 5943.167956486095, 5959.374265702038, 5963.19496867926, 5975.073863551156, 6004.579679422399, 4554.203014472454, 4555.40779698637, 4556.270996640522, 4557.498675145731, 4577.8397756078375, 3990.86031988879, 4015.7791321477016, 4049.805307434314, 4079.653229475528, 4114.238865809834, 5664.433556644302, 5692.288463942007, 5723.971380143156, 5735.397783232784, 5754.971225143848, 6004.189434426384, 6013.609115407485, 6018.097285407224, 6021.939780602225, 6025.849353766191, 5516.889662206733, 5664.461876121762, 5715.457031581993, 5715.5713321500225, 5824.854378640568, 4904.558589726942, 4905.828296009622, 4906.955916011572, 4915.705057696549, 4925.605951523869, 6298.023806309938, 6306.0, 6309.242890853127, 6324.0, 6325.272593651697, 5859.970700146472, 5968.074948383008, 6024.457798798042, 6083.300420451705, 6101.145839582373, 6322.304546499973, 6365.108884756045, 6396.008618664115, 6402.0, 6415.166028416276, 5950.434708702666, 5956.731947062306, 5958.433948774859, 5964.821055368346, 5977.760889564543, 5869.706514674163, 6029.969850150721, 6097.298810636834, 6123.7244324006415, 6129.509639228941, 5888.205092312483, 5918.704064796829, 5923.052311630118, 5925.288965324189, 5939.049752039653, 5738.770449182153, 5857.47282744555, 5883.882322353615, 5920.319163296276, 5923.229980102559, 5761.078227483583, 5809.564282678901, 5811.709414529341, 5850.765969361348, 5860.560457965585, 5793.304803423616, 5801.042827933344, 5816.302043754777, 5823.068309070529, 5838.416158384128, 5573.414791446839, 5690.71546422669, 5692.601517893708, 5740.741666625096, 5768.538516918553], "value": 5531.336740325929, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.5416185750902, 684.4182444921817, 686.8763622547939, 738.4719925253443, 749.4903465643362, 32911.67088329116, 33676.158096047584, 40000.99999999996, 40641.187176256455, 40659.0, 42950.14099718004, 43513.12973740531, 43531.56468435322, 43573.34639980395, 43619.56380436195, 8813.471191728517, 8966.282697384226, 8996.8650470243, 8998.820023599525, 9004.504752238625, 8808.603612837438, 8929.464232146092, 8931.062238464965, 8940.418872773249, 8945.239654629331, 8990.910090899106, 9291.907080929172, 9292.53537323131, 9304.627814887397, 9307.488088155149, 9181.58682859273, 9246.398984066082, 9258.814823703487, 9259.305552083588, 9266.536673166349, 9066.229370503515, 9162.679306224316, 9172.954135229347, 9176.587053582605, 9178.173964343241, 44485.110297794185, 45072.0, 45101.77449112766, 45101.77449112766, 45147.54852451499, 3655.1958569114754, 3717.739758216926, 3784.2431513697097, 3912.960870391288, 4414.4923333816705, 33420.49869251963, 33821.83089084563, 34045.829770850985, 34146.0, 35224.11939701528, 4419.0940857124215, 4426.380306757057, 4511.526289739563, 4522.9547704522865, 4525.773711314454, 243030.0, 244373.0, 244629.0, 244837.99999999822, 245325.0, 39348.213035739696, 64318.678406607665, 64978.35021649818, 65179.0, 65211.34788652148, 38059.61940380616, 38174.618253817665, 38183.427248591295, 38211.0, 38217.0, 16209.108499032667, 16416.589585260226, 16423.096729679743, 16436.83563164353, 16440.424585139463, 14820.0, 14832.703345933021, 14945.402183912522, 14962.102273863604, 14962.625934351729, 9358.625654973861, 9370.62517499306, 9436.433813971184, 9454.43273403598, 9478.241740660731, 3501.614822369588, 3566.411542095525, 3568.7145028397667, 3586.103474131467, 3640.417533194729, 1123.8707548631849, 1162.6802629276847, 1185.525789684116, 1190.0598527163618, 1202.3687564028955, 33828.13945233036, 34653.30693386118, 34694.30611387758, 34705.30589388248, 35046.0, 1243.4715246020405, 1248.3321423038813, 1267.9809802852965, 1311.0953442124903, 1333.4199623163954, 18149.092545372678, 18257.543561411072, 18355.265789368543, 18461.907690461463, 18474.44576662702, 494940.0, 498999.0, 502324.0, 503879.0, 507044.0, 63546.0, 64434.0334894977, 64504.0, 64514.6774266135, 64526.6773666138, 1421.587739555538, 1451.1148199598238, 1496.1546726099718, 1503.5714821275883, 1503.9398424063133, 30749.385012300078, 31192.532112017885, 33381.0, 33393.996360218465, 33944.0, 50935.0, 51153.488465114875, 51504.22743658923, 51532.74233628958, 51575.74212128916, 315669.0, 315716.0, 317225.0, 317654.0, 426455.0, 31022.22444438907, 31242.0, 31248.843755781076, 31269.530957036117, 31343.21641958969, 44199.558004419545, 44587.108257834014, 44629.33056004097, 45654.0, 45712.31431528463, 37197.44203836891, 37633.81183094067, 38223.617763822, 38380.616193837704, 38740.80629596834, 37309.0, 37606.435903462014, 39780.20439591134, 40788.79605601953, 40890.79554602208, 42332.153356932075, 43283.35074973815, 43601.56398435975, 43628.56371436245, 43752.124957501306, 35939.0, 36861.44707829331, 36978.815105924295, 37224.441633374976, 37800.43299350457, 28846.423071538873, 28929.56605650875, 28936.421271574873, 29105.563416549194, 29205.415891681623], "value": 19378.820403649202, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.90845922356306, 436.1212157502631, 440.24937481593884, 447.69780398231194, 450.5778611446068, 18976.43070707879, 19081.71377429338, 19519.219231230752, 21072.15711371543, 21123.0, 20038.899805500987, 20105.798942010577, 20368.592628147464, 20425.795742042574, 20457.897710511428, 4969.900601987958, 5209.661372010826, 5214.843554693365, 5217.713025783581, 5218.32161818963, 3929.4302326162688, 4421.960839202785, 5117.872053198681, 5190.558802501791, 6440.484761219114, 6386.105945167657, 6412.358764123597, 6420.486361091102, 6423.678816059201, 6427.196600424947, 5807.0, 5880.794172203995, 5886.882262354772, 6362.5546211765195, 6367.267764207106, 5823.126531020339, 5825.0, 5825.970870145622, 5832.766689332421, 5854.268216472941, 14511.782323265159, 22689.432764180863, 23668.289951301318, 23734.287971360885, 23864.0, 2248.5615305015526, 2346.8005219556358, 2391.497785465054, 2436.3665446983737, 2505.649209110708, 10463.633772817915, 10478.895211047944, 10737.194710396752, 10965.451727413678, 14399.496017639332, 1873.784514780804, 1922.144645632694, 1936.06101040995, 2029.573789504206, 2122.6922096296107, 53392.73303633496, 53722.73138634321, 53831.19253211205, 59527.70236148835, 82745.58627206825, 11414.37220952839, 11752.647420577225, 11802.46888890002, 11881.940590296994, 11975.880241197476, 16772.58068548296, 16885.83114168867, 16897.408590699266, 16922.0, 16922.0, 8446.662133514714, 8842.159994800484, 8862.468251904906, 8960.372773905765, 9012.27901767857, 8776.78058048554, 8809.823803524021, 8834.911650883409, 8899.243564296978, 8918.509481978554, 4977.701337919736, 5188.066148093304, 5201.141811601119, 5207.427183009866, 5240.868978275497, 2065.8450616203845, 2067.7725450200464, 2070.8653937494314, 2087.6137914485566, 2114.6831961413372, 995.328153496387, 1025.5846382215216, 1070.2240875365453, 1083.3554035348955, 1146.2721172055806, 17266.740998885027, 19972.800271997385, 20280.594388112157, 20313.187472500933, 20455.8977205113, 1084.0352086642895, 1102.9558817647364, 1116.1294190531398, 1125.6848082536903, 1137.4597066393396, 11155.776884462266, 11425.2002359834, 11443.485043173077, 11499.137564682682, 11537.423128843524, 497264.0, 500367.0, 502371.0, 504443.0, 507296.0, 100884.0, 101724.0, 102539.0, 102917.0, 103218.0, 996.3125443444001, 1056.4400867540062, 1118.552578968403, 1141.7659379827116, 1156.3524426321287, 17115.400960966803, 17187.57031074183, 17382.304707811545, 17491.21289541999, 17502.387416440364, 38321.80839095786, 38517.422238667, 38579.80710096432, 39109.0, 39318.2136357277, 63361.68319158375, 64602.676986614766, 64887.67556162189, 65360.346396535424, 65472.67263663651, 9308.813823723623, 9310.860337094813, 9330.160285574331, 9472.052794720474, 9495.43027418357, 12872.22766634005, 13069.803952940903, 14008.789868151782, 14046.508372207332, 14131.0, 11721.941390292994, 11746.353950532803, 11758.823617645914, 11857.0, 12155.392230388623, 11479.966802987772, 11514.53941842317, 11647.59233426826, 11740.354280514654, 11869.525218991144, 12058.216215945935, 12544.498220071095, 12697.238165710087, 12912.418941147484, 12916.677083072998, 9106.180443760093, 9280.0, 9403.4828084456, 9412.67055653049, 9471.715848524555, 8976.371653984159, 12331.568395106127, 12372.690682733004, 12391.256524608552, 12406.379681015733], "value": 9559.001222082106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.3187438155308, 1507.5175943698014, 1529.9694006119878, 1711.4865540337903, 1886.349209522714, 7383.741569045078, 8098.919010809897, 8346.374021948355, 8374.120717324684, 8386.20331068549, 8332.500049997005, 8334.333253339733, 8419.284360829322, 8422.747317580466, 8434.451760635555, 2464.950700985979, 2495.388629785696, 2495.9376015599573, 2495.987520062397, 2497.625356196576, 2417.226487523993, 2481.4788894332214, 2496.3759060234943, 2499.250224932522, 2514.8365356251784, 2482.577961746498, 2488.14159115105, 2497.1759319424546, 2502.674652295208, 2502.737212592679, 2421.358340039882, 2451.8283720139507, 2456.299954512955, 2459.938501537458, 2462.212092130519, 2335.74306826249, 2355.470019245673, 2361.5276944611146, 2362.65741467488, 2494.9750502494926, 8232.259096681328, 8509.82980340396, 8573.22840944318, 8578.785530361729, 8581.656733730642, 5420.810271640474, 5463.836084917459, 5514.420985796514, 5525.889482210374, 5526.143447765603, 3351.279474912881, 3371.848266827974, 3399.4673967894078, 3429.639887811769, 3442.2599141184514, 1078.735709751108, 1084.6474895658864, 1099.367863478503, 1138.1691365303293, 1154.2382027861572, 11554.653360399201, 11741.530338786439, 12174.0, 12176.634700958897, 12197.695057623541, 4668.486466488684, 4719.551642593948, 4735.195016847144, 4746.762661866962, 4800.399950006249, 9643.0, 9745.56144973478, 9751.804963900682, 9754.414735115915, 9763.853542196874, 5462.0, 5539.0, 5547.1679248113105, 5557.833265002057, 5572.3870374258795, 4412.84555040572, 4913.410390753133, 4995.475475075064, 5018.949810501921, 5045.672031317952, 3942.3639189735936, 3977.622125898035, 4023.4970628671417, 4042.191561687674, 4079.755214687128, 1249.425264378378, 1272.9872701273055, 1282.8075788631593, 1283.230061962815, 1297.8896793772446, 975.5707488705089, 979.8285300072602, 982.037603148918, 999.3753903810118, 1015.619142821442, 5679.403662615448, 5691.516221121251, 5691.9146212806845, 5764.164196191528, 5826.300843898674, 463.0992719161199, 469.66419010407725, 470.5177193376816, 476.20949224287517, 489.9853004409873, 3687.4100143976834, 3706.4625629283605, 3714.851405943732, 3723.94414083789, 3726.273376691519, 10365.792684146425, 10698.51856666452, 10866.945665271624, 10889.727756805985, 10922.29005114665, 10567.947160264303, 10723.14214862809, 10738.570457181626, 10771.353718776898, 10793.892061079447, 8281.54451505173, 8350.66597336112, 8355.874661880076, 8362.790930226914, 8365.07984121746, 5517.475839795213, 5534.280543529316, 5566.304211973504, 5637.3235211774845, 5673.8297851064535, 9210.585523651585, 9363.344565880596, 9423.38747981379, 9515.76210594713, 9523.476208808583, 9056.864147037932, 9399.248060155307, 9519.666811661835, 9601.423914565148, 9611.855822162814, 6755.290694477206, 7135.357817796424, 7234.385077268281, 7294.63526823646, 7414.332710055905, 7964.163762805054, 7987.321077708228, 8006.799830004296, 8035.276825085771, 8036.075851277178, 7134.429245660439, 7373.77878663641, 7387.556746595222, 7465.365443937326, 7466.066741657293, 7401.089883127705, 7417.517861338995, 7481.812954676177, 7530.209328020698, 7540.54756714577, 6913.1358580177475, 6945.0971373721095, 6979.616121113185, 6988.440924725908, 7006.439484841098, 4877.3903262092235, 5065.924011139762, 5096.821611243588, 5148.2020286855595, 5167.767450464813, 4925.655204135676, 4994.4755800640405, 5113.565346945551, 5195.012947539955, 5221.321228240305], "value": 4511.252515012819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.19203923505614, 373.62264113245647, 377.86396897117044, 378.1095520050281, 378.9355809512384, 6089.29973053099, 6175.228096487939, 6208.037754148103, 6233.812985610428, 6246.156768836211, 5941.910871336933, 6159.846003849895, 6160.84597885052, 6161.137440758297, 6166.568340216176, 4680.040591678706, 4728.385309909707, 4739.786709598076, 4750.192467280571, 4757.310190022445, 4655.88360290992, 4666.8366607168755, 4749.76251187441, 4752.59602933751, 4767.451743049542, 4551.203539380595, 4714.5756881880625, 4748.3589715388325, 4775.426948766153, 4778.139934811733, 4639.443266807971, 4672.11229866326, 4674.929876051862, 4759.071980963713, 4762.404699412574, 4207.284761590537, 4222.535521092677, 4224.028473451123, 4231.386448964883, 4235.23765722173, 5980.491658209057, 5992.43071908168, 5993.101034844764, 6007.15899774032, 6009.75960961561, 5560.471755183251, 5568.693721845297, 5573.41479144688, 5592.972035139839, 5594.916076258859, 6474.6762661866715, 6576.309487503839, 6646.468282537386, 6647.1026411434805, 6653.035309880041, 4679.859604211845, 4682.555157260055, 4692.718436893797, 4695.248760198352, 4698.365720627706, 6832.555883867582, 6869.931300687029, 6875.759348422781, 6877.58734475928, 6882.7591034314055, 4795.472498025214, 4800.543948324904, 4800.66395352329, 4805.4233491980485, 4805.423349198119, 4864.416270047546, 4865.343178670905, 4866.683665561727, 4870.05034018363, 4871.80512779492, 5558.638688485235, 5561.694106824082, 5565.1374037024325, 5572.665640061528, 5577.6932268724795, 6469.191351081115, 6621.33786621334, 6622.503312251601, 6627.768028119089, 6637.900431493532, 1708.1630001299275, 1723.7069698151345, 1733.514615907548, 1734.6270551831417, 1735.479356193137, 1103.3545375954996, 1130.8247221680654, 1137.3176094343328, 1155.8555180602425, 1160.193665402554, 6313.242410910629, 6426.935730642727, 6471.6764161791725, 6492.577982431127, 6499.252585952676, 6867.587944723333, 6873.725050998004, 6875.0, 6885.586864788129, 6889.138857642794, 6477.4170324671, 6484.967575162188, 6485.319041500669, 6488.837779055467, 6490.675466226669, 3654.14127679995, 3677.6138505456543, 3690.372636651722, 3691.686206672463, 3697.6302369762807, 7039.084918960605, 7180.174279957767, 7196.820079498055, 7211.098612673416, 7213.278672132849, 6975.79072627822, 6990.475714321345, 6992.300769922967, 6993.860122797516, 6998.7900362988175, 7157.0, 7172.569645821268, 7176.569405835667, 7186.748463803847, 7187.101612298358, 6841.589504629738, 6849.041134241111, 6849.212340580897, 6859.691313890787, 6861.519693621399, 6571.671416429255, 6745.392914637509, 6753.561018533779, 6761.661916904037, 6763.5941843489545, 7115.857682846417, 7163.176234733072, 7165.820854478679, 7166.462515311268, 7183.0, 4797.2564252540915, 4798.880027999188, 4803.615710743202, 4805.471398146271, 4806.639502037291, 6815.556988795713, 6831.89752153728, 6836.589804611739, 6836.863262734618, 6856.0, 6453.677316134268, 6614.801555953329, 6615.0, 6625.17185351831, 6638.701258443285, 6534.542582019213, 6576.079348891255, 6580.703868325841, 6583.144191255106, 6597.60414375139, 6481.4814814815645, 6484.286728459771, 6487.3188315226225, 6491.221053473613, 6492.740290388331, 6624.768133115318, 6634.933650663625, 6645.900311495235, 6648.235452922976, 6658.63377514222, 6334.714937827716, 6487.643179625166, 6491.772787952399, 6496.512761542808, 6507.6746162692625], "value": 5027.911849762113, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.2209061252627, 916.7341470973419, 920.1626519866918, 930.7440453875183, 941.7692665297003, 13657.590272291822, 13940.302984850743, 14053.789193162085, 14071.29643517824, 14079.718405631882, 13211.405486753096, 13211.93394033031, 13286.468541258362, 13797.103188292755, 13835.654108647288, 896.932730045246, 908.4957848394139, 909.172652885874, 915.555955361649, 916.2395211974045, 886.4016788667656, 890.679355432044, 891.3671293381707, 894.2354287084546, 894.3694695239873, 946.6213514594149, 953.9904600953971, 960.9471479068649, 961.3462845265217, 961.4808003678005, 943.4197968249512, 943.688582767685, 944.2398868910524, 945.7777422305787, 951.1107114847605, 689.9862002759967, 692.0829900381964, 694.5832500499711, 695.9304069593051, 698.2354322017383, 13849.238291893942, 13862.93068534661, 13943.0, 13955.651108722263, 15135.091894486366, 13573.107710009248, 14180.929095354457, 14289.785653215211, 14518.854811451962, 14563.70872582553, 11181.776364472666, 11581.710457238636, 11690.47392867323, 11973.0, 12265.57070502528, 3927.293087244295, 3940.704447166474, 3967.940480892789, 3974.7813870237123, 4047.150098479323, 55314.72342638261, 55453.722731386086, 55456.72271638616, 55492.0, 56508.0, 11502.712432189262, 11660.416979151178, 11730.88269117298, 11852.585159519376, 12046.638600841989, 20929.372118836458, 20931.0, 20936.162553497994, 20979.370618881458, 20999.8950005249, 8771.429857059271, 8789.736307910773, 8934.821303573892, 9146.95426522863, 9255.398399104037, 4925.8029678812445, 4952.678075925053, 4965.950340496621, 5128.358955130609, 5143.151380022255, 3656.0, 3694.9630503695157, 3701.241245544657, 3706.2031663192543, 3709.9443508347395, 671.1476424940298, 676.2865177237962, 681.8090934538337, 686.4954258619911, 689.1764341611826, 715.9463040272001, 792.3581898662102, 824.7938015496126, 836.506461187902, 849.218718778725, 9432.481213533321, 9874.061964113398, 9947.950260248652, 10001.689474573448, 10022.098011178883, 742.7511783552462, 751.3538357012965, 753.8266198774313, 768.9653965571563, 771.2095102519962, 4519.412476378116, 4629.537046295343, 4647.37260469839, 4697.78859951303, 4717.339572459859, 65408.345916540224, 65766.67116664386, 66516.33483665198, 67903.32096679069, 68200.0, 45807.312890306675, 59709.40290597038, 59956.0, 60177.097343539885, 65318.0, 51655.7417212919, 52086.739566302684, 52159.217611735854, 53645.73177134089, 54510.45489545054, 8889.710991906266, 9034.593443295198, 9266.53667316618, 9330.95334523323, 9350.766230844283, 41167.0, 41214.0, 41356.379654304605, 41995.37006944959, 42994.57005429906, 51104.233436497736, 52364.476355237486, 52531.21203181879, 54884.0, 55153.448465516434, 12827.358632068546, 13691.452341906212, 13966.79049814274, 14037.719245614826, 14513.419463221353, 12928.353582321035, 13278.925105747698, 13468.93265533666, 13604.115732477358, 13775.931120344734, 12874.935625321814, 13196.60410187696, 13295.335233238493, 13357.13178643385, 13415.597532074053, 12560.0, 12560.811587826007, 12675.746485070431, 12738.808917866054, 12784.169029013085, 12291.139620226499, 12627.431765570755, 12972.0, 12981.935090324489, 13185.53850615224, 10291.7427064321, 10329.9483502585, 10345.637902673672, 10619.097376722755, 10687.25189236777, 9712.3201375903, 10591.311564748266, 10708.839367409651, 10805.0, 10828.675139745821], "value": 7180.646818610882, "unit": "score"}], "name": "dromaeo_css", "value": 7420.09448077525, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 111.0, 111.0, 112.0, 105.0, 110.0, 112.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 165.0, 189.0, 125.0, 149.0, 151.0, 133.0, 177.0, 127.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 161.0, 159.0, 161.0, 160.0, 162.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 174.0, 77.0, 74.0, 77.0, 76.0, 164.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 159.0, 98.0, 93.0, 93.0, 153.0, 91.0, 92.0, 148.0], "value": 111.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 56.0, 56.0, 58.0, 76.0, 54.0, 55.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 74.0, 74.0, 74.0, 74.0, 75.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 117.0, 119.0, 119.0, 114.0, 114.0, 113.0, 128.0, 114.0], "value": 116.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 158.0, 160.0, 165.0, 158.0, 157.0, 159.0, 157.0, 157.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 68.0, 64.0, 66.0, 65.0, 64.0, 66.0, 64.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1513.2, "alertThreshold": 2.0}]} 15:45:15 INFO - Return code: 0 15:45:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:45:15 ERROR - # TBPL SUCCESS # 15:45:15 INFO - Running post-action listener: _resource_record_post_action 15:45:15 INFO - Running post-run listener: _resource_record_post_run 15:45:16 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 7532544; Write bytes: 349212672; Read time: 1032; Write time: 321624 15:45:16 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 4501504; Read time: 0; Write time: 720 15:45:16 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5771264; Write bytes: 344711168; Read time: 984; Write time: 320904 15:45:16 INFO - Running post-run listener: _upload_blobber_files 15:45:16 INFO - Blob upload gear active. 15:45:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:45:16 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:45:16 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:45:16 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:45:16 INFO - (blobuploader) - INFO - Open directory for files ... 15:45:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:45:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:45:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:17 INFO - (blobuploader) - INFO - Done attempting. 15:45:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:45:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:45:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:20 INFO - (blobuploader) - INFO - Done attempting. 15:45:20 INFO - (blobuploader) - INFO - Iteration through files over. 15:45:20 INFO - Return code: 0 15:45:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:45:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:45:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be0ef356fff2c0138cd2bf56c4fc68b2a20f14b5196c9749eda7618f8cf826c3bafd4b48c0aca494a8b7bd3771ee7b6ba53df89e5fc702545d856a14fea0e933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/522fd1361577eaac01a5d64e716015052fb7ac51612db3c3a31788c007bbec0fb71b83f6c9e9eb5bb5840497692f320e4592af35102fd41c4a0ab6a25a33d297"} 15:45:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:45:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:45:20 INFO - Contents: 15:45:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be0ef356fff2c0138cd2bf56c4fc68b2a20f14b5196c9749eda7618f8cf826c3bafd4b48c0aca494a8b7bd3771ee7b6ba53df89e5fc702545d856a14fea0e933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/522fd1361577eaac01a5d64e716015052fb7ac51612db3c3a31788c007bbec0fb71b83f6c9e9eb5bb5840497692f320e4592af35102fd41c4a0ab6a25a33d297"} 15:45:20 INFO - Running post-run listener: copy_logs_to_upload_dir 15:45:20 INFO - Copying logs to upload dir... 15:45:20 INFO - mkdir: /builds/slave/test/build/upload/logs 15:45:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.962284 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-30 15:45:20.913419) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 15:45:20.916813) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be0ef356fff2c0138cd2bf56c4fc68b2a20f14b5196c9749eda7618f8cf826c3bafd4b48c0aca494a8b7bd3771ee7b6ba53df89e5fc702545d856a14fea0e933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/522fd1361577eaac01a5d64e716015052fb7ac51612db3c3a31788c007bbec0fb71b83f6c9e9eb5bb5840497692f320e4592af35102fd41c4a0ab6a25a33d297"} build_url:https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011044 build_url: 'https://queue.taskcluster.net/v1/task/QW8MI4CTTFyE7_ccCYc_4g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be0ef356fff2c0138cd2bf56c4fc68b2a20f14b5196c9749eda7618f8cf826c3bafd4b48c0aca494a8b7bd3771ee7b6ba53df89e5fc702545d856a14fea0e933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/522fd1361577eaac01a5d64e716015052fb7ac51612db3c3a31788c007bbec0fb71b83f6c9e9eb5bb5840497692f320e4592af35102fd41c4a0ab6a25a33d297"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 15:45:20.942322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:45:20.942667) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467325483.255961-4153687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004375 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:45:21.028908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 15:45:21.029539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 15:45:21.030388) ========= ========= Total master_lag: 0.19 =========