builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1461886540.94 results: success (0) buildid: 20160428145145 builduid: e615004c3e98419383020ca3b5af7909 revision: 7828a91e6f834dad9603697ccf0fb92522c49ee5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:40.942548) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:40.943019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:40.943314) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:40.979176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:40.979843) ========= 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=af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 16:35:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-04-28 16:35:41 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:41.071266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:41.071563) ========= 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=af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018140 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:41.121543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:41.121921) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7828a91e6f834dad9603697ccf0fb92522c49ee5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7828a91e6f834dad9603697ccf0fb92522c49ee5 --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=af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 16:35:41,786 truncating revision to first 12 chars 2016-04-28 16:35:41,787 Setting DEBUG logging. 2016-04-28 16:35:41,787 attempt 1/10 2016-04-28 16:35:41,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7828a91e6f83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 16:35:42,062 unpacking tar archive at: fx-team-7828a91e6f83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:41.692964) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:41.693273) ========= script_repo_revision: 7828a91e6f834dad9603697ccf0fb92522c49ee5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:41.693688) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:41.693975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 16:35:41.707153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-28 16:35:41.707431) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:35:42 INFO - MultiFileLogger online at 20160428 16:35:42 in /builds/slave/test 16:35:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:35:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:35:42 INFO - {'append_to_log': False, 16:35:42 INFO - 'base_work_dir': '/builds/slave/test', 16:35:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:35:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:35:42 INFO - 'branch': 'Fx-Team-Non-PGO', 16:35:42 INFO - 'buildbot_json_path': 'buildprops.json', 16:35:42 INFO - 'config_files': ('talos/linux_config.py',), 16:35:42 INFO - 'default_actions': ('clobber', 16:35:42 INFO - 'read-buildbot-config', 16:35:42 INFO - 'download-and-extract', 16:35:42 INFO - 'populate-webroot', 16:35:42 INFO - 'create-virtualenv', 16:35:42 INFO - 'install', 16:35:42 INFO - 'run-tests'), 16:35:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:35:42 INFO - 'download_minidump_stackwalk': True, 16:35:42 INFO - 'download_symbols': 'ondemand', 16:35:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:35:42 INFO - 'tooltool.py': '/tools/tooltool.py', 16:35:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:35:42 INFO - '/tools/misc-python/virtualenv.py')}, 16:35:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:35:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:35:42 INFO - 'installer_path': 'installer.exe', 16:35:42 INFO - 'log_level': 'info', 16:35:42 INFO - 'log_name': 'talos', 16:35:42 INFO - 'log_to_console': True, 16:35:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:35:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:35:42 INFO - 'opt_config_files': (), 16:35:42 INFO - 'pip_index': False, 16:35:42 INFO - 'sps_profile': False, 16:35:42 INFO - 'sps_profile_interval': 0, 16:35:42 INFO - 'suite': 'dromaeojs', 16:35:42 INFO - 'system_bits': '32', 16:35:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:35:42 INFO - 'title': 'talos-linux64-ix-020', 16:35:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:35:42 INFO - 'use_talos_json': True, 16:35:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:35:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:35:42 INFO - 'work_dir': 'build'} 16:35:42 INFO - ##### 16:35:42 INFO - ##### Running clobber step. 16:35:42 INFO - ##### 16:35:42 INFO - Running pre-action listener: _resource_record_pre_action 16:35:42 INFO - Running main action method: clobber 16:35:42 INFO - rmtree: /builds/slave/test/build 16:35:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:35:42 INFO - Running post-action listener: _resource_record_post_action 16:35:42 INFO - ##### 16:35:42 INFO - ##### Running read-buildbot-config step. 16:35:42 INFO - ##### 16:35:42 INFO - Running pre-action listener: _resource_record_pre_action 16:35:42 INFO - Running main action method: read_buildbot_config 16:35:42 INFO - Using buildbot properties: 16:35:42 INFO - { 16:35:42 INFO - "project": "", 16:35:42 INFO - "product": "firefox", 16:35:42 INFO - "script_repo_revision": "production", 16:35:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:35:42 INFO - "repository": "", 16:35:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:35:42 INFO - "buildid": "20160428145145", 16:35:42 INFO - "pgo_build": "False", 16:35:42 INFO - "basedir": "/builds/slave/test", 16:35:42 INFO - "buildnumber": 2908, 16:35:42 INFO - "slavename": "talos-linux64-ix-020", 16:35:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:35:42 INFO - "platform": "ubuntu64_hw", 16:35:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:35:42 INFO - "branch": "fx-team", 16:35:42 INFO - "repo_path": "integration/fx-team", 16:35:42 INFO - "revision": "7828a91e6f834dad9603697ccf0fb92522c49ee5", 16:35:42 INFO - "stage_platform": "linux64", 16:35:42 INFO - "builduid": "e615004c3e98419383020ca3b5af7909", 16:35:42 INFO - "slavebuilddir": "test" 16:35:42 INFO - } 16:35:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:35:42 INFO - Running post-action listener: _resource_record_post_action 16:35:42 INFO - ##### 16:35:42 INFO - ##### Running download-and-extract step. 16:35:42 INFO - ##### 16:35:42 INFO - Running pre-action listener: _resource_record_pre_action 16:35:42 INFO - Running main action method: download_and_extract 16:35:42 INFO - mkdir: /builds/slave/test/build/tests 16:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:42 INFO - https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:35:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:35:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:35:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:35:46 INFO - Downloaded 1361 bytes. 16:35:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:35:46 INFO - Using the following test package requirements: 16:35:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:35:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:35:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:35:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:46 INFO - u'jsshell-linux-x86_64.zip'], 16:35:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:35:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:35:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:35:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:35:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:35:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:35:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:35:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:46 INFO - https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:35:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:35:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:35:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:35:50 INFO - Downloaded 22301146 bytes. 16:35:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:35:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:35:51 INFO - Return code: 0 16:35:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:51 INFO - https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:35:56 INFO - Downloaded 22301146 bytes. 16:35:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:35:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:35:57 INFO - Return code: 0 16:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:57 INFO - https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:35:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:35:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:35:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:35:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:35:58 INFO - Downloaded 10840145 bytes. 16:35:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:35:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:35:59 INFO - Return code: 0 16:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:59 INFO - https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:35:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:35:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:35:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:36:00 INFO - Downloaded 54851335 bytes. 16:36:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:36:00 INFO - mkdir: /builds/slave/test/properties 16:36:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:36:00 INFO - Writing to file /builds/slave/test/properties/build_url 16:36:00 INFO - Contents: 16:36:00 INFO - build_url:https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:36:01 INFO - Running post-action listener: _resource_record_post_action 16:36:01 INFO - Running post-action listener: set_extra_try_arguments 16:36:01 INFO - ##### 16:36:01 INFO - ##### Running populate-webroot step. 16:36:01 INFO - ##### 16:36:01 INFO - Running pre-action listener: _resource_record_pre_action 16:36:01 INFO - Running main action method: populate_webroot 16:36:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:01 INFO - '--tppagecycles', 16:36:01 INFO - '7'], 16:36:01 INFO - 'tests': ['tsvgm']}}, 16:36:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:36:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:36:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:36:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:36:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:01 INFO - 'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:01 INFO - 'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['damp', 'tps']}, 16:36:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:01 INFO - 'tests': ['damp', 'tps']}, 16:36:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['dromaeo_dom']}, 16:36:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['a11yr', 16:36:01 INFO - 'ts_paint', 16:36:01 INFO - 'tpaint', 16:36:01 INFO - 'sessionrestore', 16:36:01 INFO - 'sessionrestore_no_auto_restore', 16:36:01 INFO - 'tabpaint']}, 16:36:01 INFO - 'other-e10s': {'tests': ['a11yr', 16:36:01 INFO - 'ts_paint', 16:36:01 INFO - 'tpaint', 16:36:01 INFO - 'sessionrestore', 16:36:01 INFO - 'sessionrestore_no_auto_restore', 16:36:01 INFO - 'tabpaint']}, 16:36:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:36:01 INFO - 'ts_paint', 16:36:01 INFO - 'tpaint', 16:36:01 INFO - 'sessionrestore', 16:36:01 INFO - 'sessionrestore_no_auto_restore', 16:36:01 INFO - 'tabpaint']}, 16:36:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:36:01 INFO - 'ts_paint', 16:36:01 INFO - 'tpaint', 16:36:01 INFO - 'sessionrestore', 16:36:01 INFO - 'sessionrestore_no_auto_restore', 16:36:01 INFO - 'tabpaint']}, 16:36:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['a11yr', 16:36:01 INFO - 'ts_paint', 16:36:01 INFO - 'tpaint', 16:36:01 INFO - 'sessionrestore', 16:36:01 INFO - 'sessionrestore_no_auto_restore', 16:36:01 INFO - 'tabpaint']}, 16:36:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['a11yr', 16:36:01 INFO - 'ts_paint', 16:36:01 INFO - 'tpaint', 16:36:01 INFO - 'sessionrestore', 16:36:01 INFO - 'sessionrestore_no_auto_restore', 16:36:01 INFO - 'tabpaint']}, 16:36:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['tsvgx', 16:36:01 INFO - 'tsvgr_opacity', 16:36:01 INFO - 'tart', 16:36:01 INFO - 'tscrollx', 16:36:01 INFO - 'cart']}, 16:36:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:36:01 INFO - 'tsvgr_opacity', 16:36:01 INFO - 'tart', 16:36:01 INFO - 'tscrollx', 16:36:01 INFO - 'cart']}, 16:36:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:01 INFO - 'talos_options': ['--disable-e10s'], 16:36:01 INFO - 'tests': ['tp5o']}, 16:36:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:01 INFO - 'tests': ['tp5o']}, 16:36:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:01 INFO - 'talos_options': ['--disable-e10s', 16:36:01 INFO - '--xperf_path', 16:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:01 INFO - 'tests': ['tp5n']}, 16:36:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:01 INFO - 'talos_options': ['--xperf_path', 16:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:01 INFO - 'tests': ['tp5n']}}, 16:36:01 INFO - 'talos.zip': {'path': '', 16:36:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:01 INFO - Running post-action listener: _resource_record_post_action 16:36:01 INFO - ##### 16:36:01 INFO - ##### Running create-virtualenv step. 16:36:01 INFO - ##### 16:36:01 INFO - Running pre-action listener: _resource_record_pre_action 16:36:01 INFO - Running main action method: create_virtualenv 16:36:01 INFO - Creating virtualenv /builds/slave/test/build/venv 16:36:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:36:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:36:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:01 INFO - Using real prefix '/usr' 16:36:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:36:02 INFO - Installing distribute.............................................................................................................................................................................................done. 16:36:03 INFO - Installing pip.................done. 16:36:03 INFO - Return code: 0 16:36:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29a5bf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:36:03 INFO - Using env: {'DISPLAY': ':0', 16:36:03 INFO - 'HOME': '/home/cltbld', 16:36:03 INFO - 'LANG': 'en_US.UTF-8', 16:36:03 INFO - 'LANGUAGE': 'en_US:en', 16:36:03 INFO - 'LOGNAME': 'cltbld', 16:36:03 INFO - 'MAIL': '/var/mail/cltbld', 16:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:03 INFO - 'MOZ_NO_REMOTE': '1', 16:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:03 INFO - 'NO_EM_RESTART': '1', 16:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:03 INFO - 'PWD': '/builds/slave/test', 16:36:03 INFO - 'SHELL': '/bin/bash', 16:36:03 INFO - 'SHLVL': '1', 16:36:03 INFO - 'TERM': 'linux', 16:36:03 INFO - 'TMOUT': '86400', 16:36:03 INFO - 'USER': 'cltbld', 16:36:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:03 INFO - '_': '/tools/buildbot/bin/python'} 16:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:36:04 INFO - Cleaning up... 16:36:04 INFO - Return code: 0 16:36:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:04 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 0x7f29a5bf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:36:04 INFO - Using env: {'DISPLAY': ':0', 16:36:04 INFO - 'HOME': '/home/cltbld', 16:36:04 INFO - 'LANG': 'en_US.UTF-8', 16:36:04 INFO - 'LANGUAGE': 'en_US:en', 16:36:04 INFO - 'LOGNAME': 'cltbld', 16:36:04 INFO - 'MAIL': '/var/mail/cltbld', 16:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:04 INFO - 'MOZ_NO_REMOTE': '1', 16:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:04 INFO - 'NO_EM_RESTART': '1', 16:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:04 INFO - 'PWD': '/builds/slave/test', 16:36:04 INFO - 'SHELL': '/bin/bash', 16:36:04 INFO - 'SHLVL': '1', 16:36:04 INFO - 'TERM': 'linux', 16:36:04 INFO - 'TMOUT': '86400', 16:36:04 INFO - 'USER': 'cltbld', 16:36:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:04 INFO - '_': '/tools/buildbot/bin/python'} 16:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:04 INFO - Downloading/unpacking psutil>=0.7.1 16:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:36:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:06 INFO - Installing collected packages: psutil 16:36:06 INFO - Running setup.py install for psutil 16:36:06 INFO - building 'psutil._psutil_linux' extension 16:36:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:36: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 16:36:06 INFO - building 'psutil._psutil_posix' extension 16:36: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 16:36: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:36:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:06 INFO - Successfully installed psutil 16:36:06 INFO - Cleaning up... 16:36:06 INFO - Return code: 0 16:36:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:06 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 0x7f29a5bf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:36:06 INFO - Using env: {'DISPLAY': ':0', 16:36:06 INFO - 'HOME': '/home/cltbld', 16:36:06 INFO - 'LANG': 'en_US.UTF-8', 16:36:06 INFO - 'LANGUAGE': 'en_US:en', 16:36:06 INFO - 'LOGNAME': 'cltbld', 16:36:06 INFO - 'MAIL': '/var/mail/cltbld', 16:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:06 INFO - 'MOZ_NO_REMOTE': '1', 16:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:06 INFO - 'NO_EM_RESTART': '1', 16:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:06 INFO - 'PWD': '/builds/slave/test', 16:36:06 INFO - 'SHELL': '/bin/bash', 16:36:06 INFO - 'SHLVL': '1', 16:36:06 INFO - 'TERM': 'linux', 16:36:06 INFO - 'TMOUT': '86400', 16:36:06 INFO - 'USER': 'cltbld', 16:36:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:06 INFO - '_': '/tools/buildbot/bin/python'} 16:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:36: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) 16:36:09 INFO - Installing collected packages: mozsystemmonitor 16:36:09 INFO - Running setup.py install for mozsystemmonitor 16:36:09 INFO - Successfully installed mozsystemmonitor 16:36:09 INFO - Cleaning up... 16:36:09 INFO - Return code: 0 16:36:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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 0x7f29a5bf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36: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 16:36: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 16:36:09 INFO - Using env: {'DISPLAY': ':0', 16:36:09 INFO - 'HOME': '/home/cltbld', 16:36:09 INFO - 'LANG': 'en_US.UTF-8', 16:36:09 INFO - 'LANGUAGE': 'en_US:en', 16:36:09 INFO - 'LOGNAME': 'cltbld', 16:36:09 INFO - 'MAIL': '/var/mail/cltbld', 16:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:09 INFO - 'MOZ_NO_REMOTE': '1', 16:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:09 INFO - 'NO_EM_RESTART': '1', 16:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:09 INFO - 'PWD': '/builds/slave/test', 16:36:09 INFO - 'SHELL': '/bin/bash', 16:36:09 INFO - 'SHLVL': '1', 16:36:09 INFO - 'TERM': 'linux', 16:36:09 INFO - 'TMOUT': '86400', 16:36:09 INFO - 'USER': 'cltbld', 16:36:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:09 INFO - '_': '/tools/buildbot/bin/python'} 16:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:36:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:36:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:11 INFO - Downloading docopt-0.6.1.tar.gz 16:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:36:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:36:12 INFO - Running setup.py install for blobuploader 16:36:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:36:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:36:12 INFO - Running setup.py install for requests 16:36:12 INFO - Running setup.py install for docopt 16:36:12 INFO - Successfully installed blobuploader requests docopt 16:36:12 INFO - Cleaning up... 16:36:12 INFO - Return code: 0 16:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:12 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 0x7f29a5bf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:36:12 INFO - Using env: {'DISPLAY': ':0', 16:36:12 INFO - 'HOME': '/home/cltbld', 16:36:12 INFO - 'LANG': 'en_US.UTF-8', 16:36:12 INFO - 'LANGUAGE': 'en_US:en', 16:36:12 INFO - 'LOGNAME': 'cltbld', 16:36:12 INFO - 'MAIL': '/var/mail/cltbld', 16:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:12 INFO - 'MOZ_NO_REMOTE': '1', 16:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:12 INFO - 'NO_EM_RESTART': '1', 16:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:12 INFO - 'PWD': '/builds/slave/test', 16:36:12 INFO - 'SHELL': '/bin/bash', 16:36:12 INFO - 'SHLVL': '1', 16:36:12 INFO - 'TERM': 'linux', 16:36:12 INFO - 'TMOUT': '86400', 16:36:12 INFO - 'USER': 'cltbld', 16:36:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:12 INFO - '_': '/tools/buildbot/bin/python'} 16:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:12 INFO - Running setup.py (path:/tmp/pip-0q5cK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:12 INFO - Running setup.py (path:/tmp/pip-ovyRxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:13 INFO - Running setup.py (path:/tmp/pip-oIMXDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:13 INFO - Running setup.py (path:/tmp/pip-yBKAdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:13 INFO - Running setup.py (path:/tmp/pip-W3klDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:13 INFO - Running setup.py (path:/tmp/pip-WnbbKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:13 INFO - Running setup.py (path:/tmp/pip-58mK5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:13 INFO - Running setup.py (path:/tmp/pip-W56Isq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:13 INFO - Running setup.py (path:/tmp/pip-YKOu3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:13 INFO - Running setup.py (path:/tmp/pip-gTs2wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:13 INFO - Running setup.py (path:/tmp/pip-7rtKov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:13 INFO - Running setup.py (path:/tmp/pip-kXXuuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:13 INFO - Running setup.py (path:/tmp/pip-7fjxHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:13 INFO - Running setup.py (path:/tmp/pip-G6tWQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:13 INFO - Running setup.py (path:/tmp/pip-W6sVhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:13 INFO - Running setup.py (path:/tmp/pip-ye6bLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:14 INFO - Running setup.py (path:/tmp/pip-y_OG1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:36:14 INFO - Running setup.py install for manifestparser 16:36:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:36:14 INFO - Running setup.py install for mozcrash 16:36:14 INFO - Running setup.py install for mozdebug 16:36:14 INFO - Running setup.py install for mozdevice 16:36:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:36:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:36:14 INFO - Running setup.py install for mozfile 16:36:14 INFO - Running setup.py install for mozhttpd 16:36:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:36:14 INFO - Running setup.py install for mozinfo 16:36:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:36:14 INFO - Running setup.py install for mozInstall 16:36:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:36:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:36:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:36:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:36:14 INFO - Running setup.py install for mozleak 16:36:14 INFO - Running setup.py install for mozlog 16:36:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:36:15 INFO - Running setup.py install for moznetwork 16:36:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:36:15 INFO - Running setup.py install for mozprocess 16:36:15 INFO - Running setup.py install for mozprofile 16:36:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:36:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:36:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:36:15 INFO - Running setup.py install for mozrunner 16:36:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:36:15 INFO - Running setup.py install for mozscreenshot 16:36:15 INFO - Running setup.py install for moztest 16:36:15 INFO - Running setup.py install for mozversion 16:36:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:36:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:36:15 INFO - Cleaning up... 16:36:15 INFO - Return code: 0 16:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:15 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 0x7f29a5bf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:36:15 INFO - Using env: {'DISPLAY': ':0', 16:36:15 INFO - 'HOME': '/home/cltbld', 16:36:15 INFO - 'LANG': 'en_US.UTF-8', 16:36:15 INFO - 'LANGUAGE': 'en_US:en', 16:36:15 INFO - 'LOGNAME': 'cltbld', 16:36:15 INFO - 'MAIL': '/var/mail/cltbld', 16:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:15 INFO - 'MOZ_NO_REMOTE': '1', 16:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:15 INFO - 'NO_EM_RESTART': '1', 16:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:15 INFO - 'PWD': '/builds/slave/test', 16:36:15 INFO - 'SHELL': '/bin/bash', 16:36:15 INFO - 'SHLVL': '1', 16:36:15 INFO - 'TERM': 'linux', 16:36:15 INFO - 'TMOUT': '86400', 16:36:15 INFO - 'USER': 'cltbld', 16:36:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:15 INFO - '_': '/tools/buildbot/bin/python'} 16:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:16 INFO - Running setup.py (path:/tmp/pip-fyFs55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36: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)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:16 INFO - Running setup.py (path:/tmp/pip-llYZ2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36: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)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:16 INFO - Running setup.py (path:/tmp/pip-UoKbRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36: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)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:16 INFO - Running setup.py (path:/tmp/pip-ZM7O5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:16 INFO - Running setup.py (path:/tmp/pip-qdgK28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:16 INFO - Running setup.py (path:/tmp/pip-B_s5qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:16 INFO - Running setup.py (path:/tmp/pip-TD_RRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:16 INFO - Running setup.py (path:/tmp/pip-uGaNmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:16 INFO - Running setup.py (path:/tmp/pip-lww3Ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:16 INFO - Running setup.py (path:/tmp/pip-futr4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:16 INFO - Running setup.py (path:/tmp/pip-8tipXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:16 INFO - Running setup.py (path:/tmp/pip-cUpPUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:16 INFO - Running setup.py (path:/tmp/pip-TcEoFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36: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)) 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:17 INFO - Running setup.py (path:/tmp/pip-8ACVKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36: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)) 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:17 INFO - Running setup.py (path:/tmp/pip-uFOPFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36: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)) 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:17 INFO - Running setup.py (path:/tmp/pip-Chfeya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36: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)) 16:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:17 INFO - Running setup.py (path:/tmp/pip-k1wouw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36: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)) 16:36: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)) 16:36: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)) 16:36: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)) 16:36: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)) 16:36: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)) 16:36:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:19 INFO - Downloading blessings-1.6.tar.gz 16:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:19 INFO - Installing collected packages: blessings 16:36:19 INFO - Running setup.py install for blessings 16:36:19 INFO - Successfully installed blessings 16:36:19 INFO - Cleaning up... 16:36:19 INFO - Return code: 0 16:36:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:19 INFO - Reading from file tmpfile_stdout 16:36:19 INFO - Current package versions: 16:36:19 INFO - argparse == 1.2.1 16:36:19 INFO - blessings == 1.6 16:36:19 INFO - blobuploader == 1.2.4 16:36:19 INFO - docopt == 0.6.1 16:36:19 INFO - manifestparser == 1.1 16:36:19 INFO - mozInstall == 1.12 16:36:19 INFO - mozcrash == 0.17 16:36:19 INFO - mozdebug == 0.1 16:36:19 INFO - mozdevice == 0.48 16:36:19 INFO - mozfile == 1.2 16:36:19 INFO - mozhttpd == 0.7 16:36:19 INFO - mozinfo == 0.9 16:36:19 INFO - mozleak == 0.1 16:36:19 INFO - mozlog == 3.1 16:36:19 INFO - moznetwork == 0.27 16:36:19 INFO - mozprocess == 0.22 16:36:19 INFO - mozprofile == 0.28 16:36:19 INFO - mozrunner == 6.11 16:36:19 INFO - mozscreenshot == 0.1 16:36:19 INFO - mozsystemmonitor == 0.0 16:36:19 INFO - moztest == 0.7 16:36:19 INFO - mozversion == 1.4 16:36:19 INFO - psutil == 3.1.1 16:36:19 INFO - requests == 1.2.3 16:36:19 INFO - wsgiref == 0.1.2 16:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:19 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 0x7f29a5bf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:36:19 INFO - Using env: {'DISPLAY': ':0', 16:36:19 INFO - 'HOME': '/home/cltbld', 16:36:19 INFO - 'LANG': 'en_US.UTF-8', 16:36:19 INFO - 'LANGUAGE': 'en_US:en', 16:36:19 INFO - 'LOGNAME': 'cltbld', 16:36:19 INFO - 'MAIL': '/var/mail/cltbld', 16:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:19 INFO - 'MOZ_NO_REMOTE': '1', 16:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:19 INFO - 'NO_EM_RESTART': '1', 16:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:19 INFO - 'PWD': '/builds/slave/test', 16:36:19 INFO - 'SHELL': '/bin/bash', 16:36:19 INFO - 'SHLVL': '1', 16:36:19 INFO - 'TERM': 'linux', 16:36:19 INFO - 'TMOUT': '86400', 16:36:19 INFO - 'USER': 'cltbld', 16:36:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:19 INFO - '_': '/tools/buildbot/bin/python'} 16:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:36:19 INFO - Cleaning up... 16:36:19 INFO - Return code: 0 16:36:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:19 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 0x7f29a5bf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:36:19 INFO - Using env: {'DISPLAY': ':0', 16:36:19 INFO - 'HOME': '/home/cltbld', 16:36:19 INFO - 'LANG': 'en_US.UTF-8', 16:36:19 INFO - 'LANGUAGE': 'en_US:en', 16:36:19 INFO - 'LOGNAME': 'cltbld', 16:36:19 INFO - 'MAIL': '/var/mail/cltbld', 16:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:19 INFO - 'MOZ_NO_REMOTE': '1', 16:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:19 INFO - 'NO_EM_RESTART': '1', 16:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:19 INFO - 'PWD': '/builds/slave/test', 16:36:19 INFO - 'SHELL': '/bin/bash', 16:36:19 INFO - 'SHLVL': '1', 16:36:19 INFO - 'TERM': 'linux', 16:36:19 INFO - 'TMOUT': '86400', 16:36:19 INFO - 'USER': 'cltbld', 16:36:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:19 INFO - '_': '/tools/buildbot/bin/python'} 16:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:20 INFO - Downloading/unpacking jsonschema 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:36:21 INFO - Downloading/unpacking functools32 (from jsonschema) 16:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:36:22 INFO - warning: no files found matching '*.txt' 16:36:22 INFO - no previously-included directories found matching 'build' 16:36:22 INFO - no previously-included directories found matching 'dist' 16:36:22 INFO - no previously-included directories found matching '.git*' 16:36:22 INFO - Installing collected packages: jsonschema, functools32 16:36:22 INFO - Running setup.py install for functools32 16:36:22 INFO - warning: no files found matching '*.txt' 16:36:22 INFO - no previously-included directories found matching 'build' 16:36:22 INFO - no previously-included directories found matching 'dist' 16:36:22 INFO - no previously-included directories found matching '.git*' 16:36:22 INFO - Successfully installed jsonschema functools32 16:36:22 INFO - Cleaning up... 16:36:22 INFO - Return code: 0 16:36:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:22 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 0x7f29a5bf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:36:22 INFO - Using env: {'DISPLAY': ':0', 16:36:22 INFO - 'HOME': '/home/cltbld', 16:36:22 INFO - 'LANG': 'en_US.UTF-8', 16:36:22 INFO - 'LANGUAGE': 'en_US:en', 16:36:22 INFO - 'LOGNAME': 'cltbld', 16:36:22 INFO - 'MAIL': '/var/mail/cltbld', 16:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:22 INFO - 'MOZ_NO_REMOTE': '1', 16:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:22 INFO - 'NO_EM_RESTART': '1', 16:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:22 INFO - 'PWD': '/builds/slave/test', 16:36:22 INFO - 'SHELL': '/bin/bash', 16:36:22 INFO - 'SHLVL': '1', 16:36:22 INFO - 'TERM': 'linux', 16:36:22 INFO - 'TMOUT': '86400', 16:36:22 INFO - 'USER': 'cltbld', 16:36:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:22 INFO - '_': '/tools/buildbot/bin/python'} 16:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:22 INFO - Downloading/unpacking flake8 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36: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 16:36:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:36:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:36:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:36:25 INFO - no previously-included directories found matching 'docs/_build' 16:36:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:36:25 INFO - Running setup.py install for pep8 16:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:36:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:36:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:36:25 INFO - no previously-included directories found matching 'docs/_build' 16:36:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:36:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:36:25 INFO - Cleaning up... 16:36:25 INFO - Return code: 0 16:36:25 INFO - Running post-action listener: _resource_record_post_action 16:36:25 INFO - Running post-action listener: _start_resource_monitoring 16:36:25 INFO - Starting resource monitoring. 16:36:25 INFO - ##### 16:36:25 INFO - ##### Running install step. 16:36:25 INFO - ##### 16:36:25 INFO - Running pre-action listener: _resource_record_pre_action 16:36:25 INFO - Running main action method: install 16:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:25 INFO - Reading from file tmpfile_stdout 16:36:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:36:25 INFO - Reading from file tmpfile_stdout 16:36:25 INFO - Output received: 16:36:25 INFO - Usage: mozinstall [options] installer 16:36:25 INFO - Options: 16:36:25 INFO - -h, --help show this help message and exit 16:36:25 INFO - -d DEST, --destination=DEST 16:36:25 INFO - Directory to install application into. [default: 16:36:25 INFO - "/builds/slave/test"] 16:36:25 INFO - --app=APP Application being installed. [default: firefox] 16:36:25 INFO - mkdir: /builds/slave/test/build/application 16:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:36:41 INFO - Reading from file tmpfile_stdout 16:36:41 INFO - Output received: 16:36:41 INFO - /builds/slave/test/build/application/firefox/firefox 16:36:41 INFO - Running post-action listener: _resource_record_post_action 16:36:41 INFO - ##### 16:36:41 INFO - ##### Running run-tests step. 16:36:41 INFO - ##### 16:36:41 INFO - Running pre-action listener: _resource_record_pre_action 16:36:41 INFO - Running main action method: run_tests 16:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:41 INFO - Python 2.7.3 16:36:41 INFO - Return code: 0 16:36:41 INFO - grabbing minidump binary from tooltool 16:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:41 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 0x2c13410>, '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 0x2c14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c147a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:36:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:36:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:41 INFO - Return code: 0 16:36:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:36:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:36:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:36:42 INFO - Return code: 0 16:36:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:36:42 INFO - Using env: {'DISPLAY': ':0', 16:36:42 INFO - 'HOME': '/home/cltbld', 16:36:42 INFO - 'LANG': 'en_US.UTF-8', 16:36:42 INFO - 'LANGUAGE': 'en_US:en', 16:36:42 INFO - 'LOGNAME': 'cltbld', 16:36:42 INFO - 'MAIL': '/var/mail/cltbld', 16:36:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:42 INFO - 'MOZ_NO_REMOTE': '1', 16:36:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:42 INFO - 'NO_EM_RESTART': '1', 16:36:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:42 INFO - 'PWD': '/builds/slave/test', 16:36:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:42 INFO - 'SHELL': '/bin/bash', 16:36:42 INFO - 'SHLVL': '1', 16:36:42 INFO - 'TERM': 'linux', 16:36:42 INFO - 'TMOUT': '86400', 16:36:42 INFO - 'USER': 'cltbld', 16:36:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475', 16:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:42 INFO - '_': '/tools/buildbot/bin/python'} 16:36:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:36:42 INFO - mozversion application_buildid: 20160428145145 16:36:42 INFO - mozversion application_changeset: 7828a91e6f834dad9603697ccf0fb92522c49ee5 16:36:42 INFO - mozversion application_display_name: Nightly 16:36:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:42 INFO - mozversion application_name: Firefox 16:36:42 INFO - mozversion application_remotingname: firefox 16:36:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:36:42 INFO - mozversion application_vendor: Mozilla 16:36:42 INFO - mozversion application_version: 49.0a1 16:36:42 INFO - mozversion platform_buildid: 20160428145145 16:36:42 INFO - mozversion platform_changeset: 7828a91e6f834dad9603697ccf0fb92522c49ee5 16:36:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:36:42 INFO - mozversion platform_version: 49.0a1 16:36:42 INFO - using testdate: 1461886602 16:36:42 INFO - actual date: 1461886602 16:36:42 INFO - starting webserver on 'localhost:54989' 16:36:42 INFO - SUITE-START | Running 2 tests 16:36:42 INFO - TEST-START | dromaeo_css 16:36:42 INFO - operating with platform_type : linux_ 16:36:42 INFO - Initialising browser for dromaeo_css test... 16:36:42 INFO - TEST-INFO | started process 21371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtRCx6/profile http://localhost:54989/getInfo.html) 16:36:48 INFO - PROCESS | 21371 | __metrics Screen width/height:1600/1200 16:36:48 INFO - PROCESS | 21371 | colorDepth:24 16:36:48 INFO - PROCESS | 21371 | Browser inner width/height: 1024/697 16:36:48 INFO - PROCESS | 21371 | __metrics 16:36:49 ERROR - PROCESS | 21371 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:36:50 INFO - TEST-INFO | 21371: exit 0 16:36:50 INFO - Browser initialized. 16:36:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:36:50 INFO - TEST-INFO | started process 21453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtRCx6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:37:02 INFO - PROCESS | 21453 | RSS: Main: 155451392 16:37:02 INFO - PROCESS | 21453 | 16:37:53 INFO - PROCESS | 21453 | 1461886673404 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:40:06 INFO - PROCESS | 21453 | Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54989/tests/dromaeo/cssquery-ext.html) 16:40:07 INFO - PROCESS | 21453 | RSS: Main: 248115200 16:40:07 INFO - PROCESS | 21453 | 16:43:10 INFO - PROCESS | 21453 | Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-ext.html (next: http://localhost:54989/tests/dromaeo/cssquery-jquery.html) 16:43:10 INFO - PROCESS | 21453 | RSS: Main: 235376640 16:43:10 INFO - PROCESS | 21453 | 16:46:13 INFO - PROCESS | 21453 | Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54989/tests/dromaeo/cssquery-mootools.html) 16:46:13 INFO - PROCESS | 21453 | RSS: Main: 242388992 16:46:13 INFO - PROCESS | 21453 | 16:49:15 INFO - PROCESS | 21453 | Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54989/tests/dromaeo/cssquery-prototype.html) 16:49:16 INFO - PROCESS | 21453 | RSS: Main: 235999232 16:49:16 INFO - PROCESS | 21453 | 16:52:19 INFO - PROCESS | 21453 | Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54989/tests/dromaeo/cssquery-yui.html) 16:52:19 INFO - PROCESS | 21453 | RSS: Main: 214441984 16:52:19 INFO - PROCESS | 21453 | 16:55:22 INFO - PROCESS | 21453 | Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-yui.html (next: http://localhost:54989/tests/dromaeo/cssquery-dojo.html) 16:55:22 INFO - PROCESS | 21453 | RSS: Main: 265900032 16:55:22 INFO - PROCESS | 21453 | 16:55:22 INFO - PROCESS | 21453 | __start_tp_report 16:55:22 INFO - PROCESS | 21453 | _x_x_mozilla_page_load 16:55:22 INFO - PROCESS | 21453 | _x_x_mozilla_page_load_details 16:55:22 INFO - PROCESS | 21453 | |i|pagename|runs| 16:55:22 INFO - PROCESS | 21453 | |0;dojo.html;2586.185351614242;2670.37246247132;2675.906343277986;2685.825421347612;2711.44415394844;4498.167838949788;4629.837955671552;4641.675082744205;4660.906781864365;4672.345871577973;4643.419572553431;4650.116477869211;4687.671862969593;4703.08289883472;4717.29240613908;4312.805923733439;4324.978375108128;4355.934660980088;4379.824807007732;4423.823047078129;4325.82696692132;4361.847335343264;4363.781810909458;4371.759553224571;4419.447569053868;4208.22147902636;4254.595813397722;4272.829086836523;4293.806778694935;4340.544242854487;4315.115401342718;4344.413504176927;4347.347897815322;4348.456442944632;4394.8461803837035;4314.3528470729325;4326.048269380732;4327.459067616548;4342.739435633872;4373.540778218305;4415.139047885664;4492.438445194351;4513.210188217082;4641.976790116028;4654.557817007379;4929.926051109201;4934.1611925972675;4935.7532123393685;4936.654434189608;4960.355153830015;4932.901341973176;4945.406551213841;4952.232403977389;4958.826441074581;5001.274815151819;4524.434445694321;4621.838235661736;4663.510331415153;4704.670673052853;4710.599599034052;5036.672616280003;5064.215046667772;5064.620153488503;5069.087564238399;5118.59051275897;4772.594329482033;4870.6103511718975;4872.317875497433;4877.756112194376;4923.286123512143;4967.354243948336;5038.042771873333;5049.545540901263;5058.645894787403;5060.089183946925;4921.704697718077;4925.827596034122;4929.137400954819;4935.062338155739;4985.9501404985485;4914.090893184701;4916.754162291871;4921;4934.7285899275885;4973.5523802857915;4170.833166673299;4231.026863821338;4232.259354612992;4233.5131459882505;4236.364545318227;3707.7775333480076;3721.0511319613865;3754.9249015019545;3755.3615885299564;3757;4235.724677895927;4251.256030194765;4302.913087152729;4348.239058164809;4349.913001740011;4926.45808961014;4944.48082951285;4947.851564453073;4955.603551715854;5000.224965130411;4148.91702165955;4254.914901701949;4257.3613957905945;4258.148370325947;4299.097189590158;4425.137098265872;4425.269830478;4451.198784218807;4490.708103973231;4508.1659892919915;4691.366665500251;4691.788869500812;4695.3426520287185;4701.106789709944;4732.550407711331;4760.190767569591;4845.1520983828395;4973.378327709036;4980.950190498049;5020.397552293748;4700.858974230779;4718.386609740712;4730.314104454904;4731.195696731495;4770.284457331428;4921.581665558468;4927.334809800631;4927.9507204927495;4928.630352723631;4959.57843583285;4848.80604775805;4995.575376093073;5005.074061298671;5037.1688671370275;5043.142665746906;4820.638452116035;4825.758712064313;4838.661293709407;4860.635452341018;4888.6577939543895;4823.493533178966;4832.927506087482;4834.057358814997;4837.903241935212;4882.121218180761;4650.37219975299;4720.787564559534;4759.262314341283;4778.665493415428;4797.56821886032;4774.689645173053;4795.976020119877;4799.736014519235;4839.491853355347;4844.95155048445;4696.600788932842;4707.505711900338;4717.410323709536;4720.291956206596;4749.382580264543 16:55:22 INFO - PROCESS | 21453 | |1;ext.html;576.1674380520147;596.0731063196728;603.3574243430746;624.7938180400463;625.3027873920579;34340;36102.81948590253;36198.45702314467;36243.637563624354;36254.643448175884;37511.81244093783;38270.23459530808;38297;38316.80841595788;38382.61617383832;7332.0468339116105;7542.132654744692;7667.079950405959;7870.881936770953;9634.47010414427;9775.657851975182;9945.254105942084;9945.602175912954;9946;9946.403215807075;9913;10049.748756281078;10051.195904327673;10059;10060.899391006105;7209.495335326529;9560.952195239013;9853.162481189036;9853.802923941552;9858;9761.267904907088;9908.058734420218;9909.653162139362;9911.603535858629;9912.752181195456;34975.475367869505;35624.28751424983;35624.821875890455;35685.64314356875;35709.28581428357;3087.336222712128;3098.7056229658147;3128.03031060372;3322.2358857462677;3734.551853777537;27957.580636290473;28159;28668.71331286702;28806.42387152266;29572.55641165384;3280.114369120348;3302.290007648343;3328.5007248912616;3332.983335083309;3407.267437500924;173898;174202;175269;176730;233013;51400.74299628478;51599.74200128976;51669.48330516722;51789.48210517847;51885.740571296905;50289;51290.48709512932;51690;51696.22455663168;51703.74148129235;12534.749305014031;14504.927475362767;14793.112413255023;14793.778093328609;14796.038257513228;10128.088472037552;10408.219383546264;10421.218408619385;10422.843657345145;10510.054095131474;17672.204750786244;17704.203310850786;17747.378841740734;17946.19242134107;17994.91002544979;6792.286809884989;6825.010373495816;6934.930650693529;6946.9652651736415;7120.181179164359;919.131420807344;924.8381533231658;938.2072149034055;961.423146112327;980.8724865767405;27186;28215;28598.85700571484;28907.132786016453;29080.127596172148;1003.508280942333;1011.3224139826187;1017.1710056304237;1044.300318786415;1059.3008614314515;14047.438102475786;14614;14941.775873361908;15063.849361506464;15467.767983480257;347933;356518;357212;358407;359201;50990.235146472834;51618.22572661413;51664.48335516672;51701;51795;1126.3523474002482;1155.5608868629868;1236.9628911132681;1281.833361662978;1287.1890708853362;24340.391490212885;26067.723155887263;26125.216243512725;26244.60633090467;27195.864020679768;40799;41191.7940410296;41731;41731.1653766929;41787;277001;278462;279869;280165;280284;20576.69134962947;23085.88457057704;23536.411589710395;23555.0577976879;24925;35385.115372115906;35782;36059.459108112875;36224.27551449009;36580;32119.51820722738;33451.83274083614;33998.66001339955;34810.65189348074;35018;33598.66401335955;34112.65887341095;34161.82919085389;34255.314893701485;34327.31345373129;33233;33870.491942621375;34122.48816267708;34233.486497702055;34310.31379372448;28144.577831332135;28617.713822862337;30100.397992040474;30458.390832183675;30830.691693082783;23770.88114559416;24023.879880600485;24112.75887241105;24138.75861241365;24166.154184603456 16:55:22 INFO - PROCESS | 21453 | |2;jquery.html;378.63165897312314;378.6573151298076;387.71309231168937;389.30897656659425;393.119412515964;16036.358545658175;16760.32958681651;17143.742843857337;17472.388466403678;17518.38685646001;16425.753613695804;16735.66528669429;17013.273787371294;17224.224909879053;17227.310907563682;5004.074246264435;5180.481951804827;5225.634205605609;5228.424873263938;5231.843044708665;3709.6290370962956;3895.824687889052;5789.8263052108505;6095.6952152392205;6099.878002439948;5984.162217289583;6039.275286965549;6040.516758659297;6065.454109130177;6075.088736689488;5856.355800861902;5996.13056106862;6006.21919150512;6007.549433792461;6012.609180403281;3430.588329400463;5093;5344.931013797217;5351.224072509464;5356.7321633918145;11750.823737643943;12406.193597416139;12409.44157512905;19407.22371105154;19451.610967780707;1983.7547648033221;1998.860079794415;2097.1820989813987;2138.0058272903175;2443.2670198940423;8765;9065.954670226607;9114.635414583408;9397.906020939772;9660.90339096607;1662.8337166283395;1726.6374061447111;1737.313761064385;1764.2325588369101;1767.3902503636225;67778.66110669416;67914.66042669804;71221.28778712198;71476.64261678659;72810.44705976488;9923.851142232872;10066.396016239049;10123.1901447884;10154.746131346776;10280.537375818107;14464.855351446562;14576.416943322149;14591;14608.853911460961;14624.634384140269;6965.721371145098;6998.545094568837;7153.105861767279;7329.486935914435;7330.5968171751065;6672.366125218096;6672.733090676318;6757.8648427031185;6848;6849.006894000442;4374.300111982067;4420.624246939046;4420.778961051935;4438.511763705989;4545.477270113913;1717.527679888041;1750.7286370612576;1819.945401637953;1822.7557813681562;1863.5620629152138;390.9843606255775;913.397157875812;915.66120535401;986.2652324018652;1004.7689031522791;10240.439890027494;16277.348906043626;18357.63284734298;18434.26262949467;18819.52507119943;834.7386591450678;875.28664138728;875.6978842299396;885.588201486312;908.9227415669742;9723.951380243196;9803.460809655395;9899.851502227473;9909.653162139435;10053.447060411601;413110;415968;430732;431199;432494;82031.58984205041;83188;84693.57653211818;85974.57012714897;86212.56893715616;905.7192270396198;907.1744712311896;939.154760715348;973.7127547373542;993.3692105512907;15449.691006180039;15554.300056497259;15567.84432155664;15579.143147127017;15678.451254206047;31162.844185778926;35073;35173.29653406969;36008.63991360053;36578.26843463063;48516.272255915486;50316.24525632192;50682.239766402796;51444.22833657423;51541.742291289804;7778.844423111619;7940.642671079931;7948;8063.35493160534;8105.230003149692;10482.004209600076;11020.393878336448;11472.655820325404;11484.770304593694;11631.709207269885;9138.268938485038;9462.668806591737;9586.185174260267;9605.519724013631;9954.651587194414;8806.20744133031;9448.149666530046;9913.553890075109;9920.355176913477;10607.681769546925;9662.855057174007;9812.460314682761;9827.213822894008;10268;10328.845067324146;7562.621868906643;7574.469787114849;7801.503518873906;7917.445778795429;8002.03975522941;8493.617787199468;9741.415515069119;10066.295359324777;10076.84884726715;10242.897571024492 16:55:22 INFO - PROCESS | 21453 | |3;mootools.html;1281.1864466064058;1440.5750303660423;1456.7086582683462;1565.5225156327322;1750.457358218953;6689.866202675944;7500.099988001441;7667.846643067135;7708.884366734504;7719.45963782534;7411.110666719987;7578.924210757905;7590.392768578514;7595.810104747384;7606.201348858373;1892.858035647332;2114.4291041418805;2205.52581195043;2221.855579387339;2251.6735073414343;2203.2619072610696;2219.323106452531;2225.2879078694823;2227.9108835646634;2241.170766816272;2111.9894400527974;2196.02276986741;2199.285232299509;2200.8129309008755;2203.3720389688942;1857.7120546315275;2163.1888041984257;2216.556688662258;2217.968644580278;2220.0564759977105;2123.0446299165283;2142.924997625076;2148.140743702516;2154.2029449103934;2163.3618082665653;7431.368333691643;7520.097588289385;7528.510646807995;7531.246875312425;7534.623268836536;4431.8670439886855;4555.658325625558;4581.5647513486165;4628.768561571908;4633.536646335373;2797.132888804457;2797.7901657375573;2871.9425611487864;2909.7817663675096;2931.897383591564;920.3557509743207;921.1249313152465;937.0582564522612;945.7588314979705;952.9666461673877;10126.088652021353;10327.27709060366;10334.844977325347;10363.430011349374;10363.948180259125;4149.398337241144;4191.497020357577;4321.58944900234;4324.524302326741;4325.9134817303475;8916.197542221102;8964.058773828785;8986.460812351279;8989.55052247385;9002.819943601222;4014.578469260686;4646.25659894422;4681.625469962395;4697.342372067913;4701.318308845198;3948.447217389568;4013.177298653827;4029.2143032108456;4045.150518391171;4067.471228740304;3560.0743806610467;3590.551181102362;3690.151265209017;3719.386301260262;3739.5512538495555;1108.2519299472824;1119.7816425797055;1125.5835340923747;1136.8863113688565;1152.706059954723;779.5128044971892;804.9597520123971;813.808754942588;835.603088532942;839.2321026261025;4885.853424397203;5012.7994880205115;5037.798488060436;5084.694918304914;5113.028524580318;417.7076046767275;424.5584592024322;430.59093860831706;912.2245047178018;958.2382006305004;3289.671032896691;3356.1945133167865;3390.1863552747654;3410.8294585270637;3442.9311413772084;9102.089791020977;9459.810803783887;9518.524073796283;9579.13787759105;9590.808183836285;9318.767030824283;9433.245340372754;9437.858432123523;9482.241420686329;9487.76280592977;6724.394804467622;6774.254831968479;7021.859562808715;7067.5052746307265;7085.14978202619;5349.514950696678;5377.462253774591;5458.399576046552;5476.67139971587;5527.2538207341495;8692.695755648521;8789;8843.867341989746;8879.422837515542;8985.550722463982;8780.341474389319;8935.195832375117;9021.097890210927;9099.1810737034;9129.269658427444;5981.880362392641;6137.539684523768;6140.846478838065;6717.126773519607;6872.862542749217;6463.806085817433;6537.8692426150255;7025.192102908231;7277.526960747535;7280.96359518199;6407.199100112486;6491.253505846699;6535.215774107138;6549.541532092708;6588.571742836701;6467.126937863328;6495.021972838172;6618.90071648916;6685.164354455693;6689.76585819494;6188;6236.968815155895;6242.531810114168;6258.780942666985;6282.246130464374;4217.261979153697;4367;4564.360989461412;4600.378948841863;4633.907321853611;4524.751138687404;4563.3839431677625;4570.131674981742;4616.792244348945;4654.697444666222 16:55:22 INFO - PROCESS | 21453 | |4;prototype.html;302.1991721936867;303.7645824486024;305.9174023013786;315.79631137916044;321.14575229888493;4800.159972004898;4860.513948605142;4870.464248932623;4874.317595536628;4878.658493905424;4784.952150478494;4811.566958973692;4819.25301578255;4834.178189707749;4837.298591704201;3636.2000359920908;3709.7032237421076;3750.5311836020496;3803.7147213958924;3825.3114439400897;3775.5469343678797;3812.7331086823797;3837.270918525471;3841.19334939663;3846.8653597124107;3613.8735144269954;3806.5622453417795;3811.1234416084317;3822.847086116552;3824.8087595620245;3650.4341827016856;3774.584795672474;3777.886663400075;3800.695944324475;3808.1622043150464;3325.1354647791504;3350.832458377096;3359.798412095282;3377.375185590649;3380.915477113067;4614.469336026366;4620.306953956933;4620.768961551909;4624.44506659203;4637.791299391535;4241.4698162729655;4259.297215959363;4281.272183728774;4322.530339684491;4330.722436881128;4966.50334966504;4992.500749925015;5012.248162775576;5017.2724954881705;5035.496450354972;3657.1771351445977;3664.72514561409;3670.687991520724;3674.412094064937;3684.7574134761508;5031.496850314939;5179.663321884065;5285.207218917155;5291.735413229323;5296.205569164617;3792.7913964732206;3799.2401519696173;3839.8080095995088;3843.9807800960816;3857.864974725871;3851.9807400963377;3874.49631547897;3881.7865017424315;3890.16361482277;3899.2396482685604;4350.412694286231;4358.237308471005;4359.106383191438;4371.30059190528;4379.759113248738;4762.880927976828;5018.42288136869;5039.546440820343;5046.646734728607;5060.797568097235;1421.978670319946;1422.0756508269708;1425.5580769961139;1429.0925262458413;1429.1496559547054;919.9448033118034;963.3689933093834;976.8534719791946;977.8875429325576;997.7006897930592;4632.2125238709505;4640.11837750833;4648.744319062416;4653.581177694024;4687.086018226413;5466.9179962300595;5468.863278418072;5471.945280547144;5500.367457742411;5502.8349149525575;4254.256004876899;4520.706154099973;4663.603593694574;4671.229247174178;4685.648576356787;2961.1560705198913;2962.837043962603;2971.539411391238;2982.568367183764;2995.341024974502;5227.581793456515;5240.480260724347;5246.3704355477585;5248.895022099613;5265.262863199156;5509.559235261169;5670.7731690732735;5696.743646535916;5709.914351284734;5724.341700704473;5195.584353251731;5214.687118772886;5228.90843662538;5229.764660590283;5251.71115588631;5476.342838859362;5584.162375643686;5587.273654424899;5602;5618.550515958796;5373.570114390761;5487.149491828773;5489.204065410413;5490;5511.696856672921;5228.189630607262;5263.578913686973;5269.631125821155;5274.97362513185;5290.550303224269;3838.2515409495995;3908.8436462542318;3926.7643941362467;3929.390944403622;3933.370660694275;5575.804846830341;5597.216389705526;5599.580031497572;5599.692016939108;5601.60788744784;5371.785128594813;5383.5423988961375;5396.568274538106;5397.406285308534;5398.163284690879;5162.251473536241;5359.196120581944;5360.571154307724;5388.946110538845;5402.378726446352;4675.298705194112;5244.921326180187;5279.841604751864;5292.52367286946;5307.85032062;4906.6320025997475;5061.848144555669;5087.160618498055;5100.591952643706;5112.130937740519;4959.305697202322;4965.8013679452415;4972.552470277547;5006.874828129326;5015.548600625962 16:55:22 INFO - PROCESS | 21453 | |5;yui.html;686.9450443964483;711.3810984443535;731.4221764805803;733.3436574266032;738.634375983888;10555.050045495904;10786.244962852603;10827.83758243625;10850.131989440846;10869.891301086996;11162.386068766215;11223.326600403982;11226.32642041478;11227.494762735676;11230.887691123085;620.3517324396017;760.6006846405626;792.4492477727981;795.0896223823719;795.594246934062;770.6840195519839;774.7482068327788;777.2499537945881;777.4713195027379;778.206229645761;656.7471523463453;824.6083110522513;829.4069740135802;830.016430529821;830.2859540794942;669.8961660942562;671.6775947545157;799.9600019998977;830.8379865926147;832.6419639554989;610.2920612089998;610.4597431273311;610.4688920639072;610.963342199465;611.0681211153027;10255.7436064099;10331.535080921376;10332.896671033268;10342.896571034269;10351.068403843616;11063.778724425467;11120.61077862271;11249.718757031058;11499.310041397543;11635.476403561861;9391.671291504832;9600.279979001532;9660.323777335589;9676.75808104796;9693.22454203662;3227.5481432599454;3232.9030129096163;3251.4960181171955;3257.120577444077;3302.554155189043;43473;43557.12885742299;43632.12735745299;43691.78154109241;43796.3430548542;9172.72481825533;9226.169644732006;9426.151646351862;9542.856857147148;9581.898081720552;16705.582360440843;16862.325506979585;16866.83133168677;16886.57783555421;16900.746488802677;6352.809415717536;6434.903476447857;6459.450946669585;6498.415142637185;6546.70539825709;3509.280597477511;3586.9282614347567;3616.349057169735;3632.2735452909524;3633.927321453609;2667.933301667435;2695.0702007807276;2716.2394529531366;2729.5769155780886;2732.5764506501523;497.38572862514764;498.12330298674595;506.12187854073153;513.6943518606423;516.4989959739047;459.55652795052936;641.7817941899776;648.7761722205831;653.4249860123061;656.6158797103748;7524.661390237453;7718.343940765098;7768.689252429953;7799.649015794303;7867.842643147105;546.7539607176707;618.6195489773756;626.029654036242;629.087822657149;666.3869240298936;3685.4656074868994;3688.870889518854;3756.154865155318;3764.0589852536864;3793.430985352164;50262.49737502651;50958.235626465634;52236.21645675318;52608.47391526112;52858.207126893125;44258.68059895521;46119.538804612195;46357.536424636;46607.30089048667;47867.76066119647;41880.58119418767;41983.790081049396;42586.361204581335;43116.35325470121;44132.3380149298;6996.580205187502;7004.509684322048;7051.1186101737285;7190.20907700163;7279.162896266997;29503.55744663789;29996.400071998873;30372;30436.239094022825;30612.234694132825;35397.469037963936;37260.6273937268;38331.04172395601;38354.80822595869;39652;9368.4378937264;9431.434113953184;9463.574139163891;9499;9715.854262185932;9830.311878168746;9876.604935802774;9930.900690992998;9954.303198776306;10081.747956301151;8799.164079412445;8949.32880033987;8995.415298005608;9106.089391061107;9163.725088247364;9235.861462078208;9337.813243734952;9364.765880853032;9368.81262374735;9564.282678799256;8576.828463430822;8707.47755134694;8750.737477875675;8761.299096072426;8860.778480538038;7519.210482899435;7704.614769261627;7801.570913599579;7802.882956755767;7959.602019899097;7856.37149028065;7919.406044546798;8005.1594582568;8175.959120204361;8274.627641756015 16:55:22 INFO - PROCESS | 21453 | __end_tp_report 16:55:22 INFO - PROCESS | 21453 | __start_cc_report 16:55:22 INFO - PROCESS | 21453 | _x_x_mozilla_cycle_collect,921 16:55:22 INFO - PROCESS | 21453 | __end_cc_report 16:55:22 INFO - PROCESS | 21453 | __startTimestamp1461887722812__endTimestamp 16:55:22 INFO - PROCESS | 21453 | 16:55:22 INFO - PROCESS | 21453 | ------- Summary: start ------- 16:55:22 INFO - PROCESS | 21453 | Number of tests: 6 16:55:22 INFO - PROCESS | 21453 | 16:55:22 INFO - PROCESS | 21453 | [#0] dojo.html Cycles:165 Average:4597.74 Median:4717.29 stddev:460.10 (9.8%) stddev-sans-first:433.61 16:55:22 INFO - PROCESS | 21453 | Values: 2586.2 2670.4 2675.9 2685.8 2711.4 4498.2 4629.8 4641.7 4660.9 4672.3 4643.4 4650.1 4687.7 4703.1 4717.3 4312.8 4325.0 4355.9 4379.8 4423.8 4325.8 4361.8 4363.8 4371.8 4419.4 4208.2 4254.6 4272.8 4293.8 4340.5 4315.1 4344.4 4347.3 4348.5 4394.8 4314.4 4326.0 4327.5 4342.7 4373.5 4415.1 4492.4 4513.2 4642.0 4654.6 4929.9 4934.2 4935.8 4936.7 4960.4 4932.9 4945.4 4952.2 4958.8 5001.3 4524.4 4621.8 4663.5 4704.7 4710.6 5036.7 5064.2 5064.6 5069.1 5118.6 4772.6 4870.6 4872.3 4877.8 4923.3 4967.4 5038.0 5049.5 5058.6 5060.1 4921.7 4925.8 4929.1 4935.1 4986.0 4914.1 4916.8 4921.0 4934.7 4973.6 4170.8 4231.0 4232.3 4233.5 4236.4 3707.8 3721.1 3754.9 3755.4 3757.0 4235.7 4251.3 4302.9 4348.2 4349.9 4926.5 4944.5 4947.9 4955.6 5000.2 4148.9 4254.9 4257.4 4258.1 4299.1 4425.1 4425.3 4451.2 4490.7 4508.2 4691.4 4691.8 4695.3 4701.1 4732.6 4760.2 4845.2 4973.4 4981.0 5020.4 4700.9 4718.4 4730.3 4731.2 4770.3 4921.6 4927.3 4928.0 4928.6 4959.6 4848.8 4995.6 5005.1 5037.2 5043.1 4820.6 4825.8 4838.7 4860.6 4888.7 4823.5 4832.9 4834.1 4837.9 4882.1 4650.4 4720.8 4759.3 4778.7 4797.6 4774.7 4796.0 4799.7 4839.5 4845.0 4696.6 4707.5 4717.4 4720.3 4749.4 16:55:22 INFO - PROCESS | 21453 | 16:55:22 INFO - PROCESS | 21453 | [#1] ext.html Cycles:180 Average:42961.97 Median:34142.16 stddev:74296.16 (217.6%) stddev-sans-first:74436.42 16:55:22 INFO - PROCESS | 21453 | Values: 576.2 596.1 603.4 624.8 625.3 34340.0 36102.8 36198.5 36243.6 36254.6 37511.8 38270.2 38297.0 38316.8 38382.6 7332.0 7542.1 7667.1 7870.9 9634.5 9775.7 9945.3 9945.6 9946.0 9946.4 9913.0 10049.7 10051.2 10059.0 10060.9 7209.5 9561.0 9853.2 9853.8 9858.0 9761.3 9908.1 9909.7 9911.6 9912.8 34975.5 35624.3 35624.8 35685.6 35709.3 3087.3 3098.7 3128.0 3322.2 3734.6 27957.6 28159.0 28668.7 28806.4 29572.6 3280.1 3302.3 3328.5 3333.0 3407.3 173898.0 174202.0 175269.0 176730.0 233013.0 51400.7 51599.7 51669.5 51789.5 51885.7 50289.0 51290.5 51690.0 51696.2 51703.7 12534.7 14504.9 14793.1 14793.8 14796.0 10128.1 10408.2 10421.2 10422.8 10510.1 17672.2 17704.2 17747.4 17946.2 17994.9 6792.3 6825.0 6934.9 6947.0 7120.2 919.1 924.8 938.2 961.4 980.9 27186.0 28215.0 28598.9 28907.1 29080.1 1003.5 1011.3 1017.2 1044.3 1059.3 14047.4 14614.0 14941.8 15063.8 15467.8 347933.0 356518.0 357212.0 358407.0 359201.0 50990.2 51618.2 51664.5 51701.0 51795.0 1126.4 1155.6 1237.0 1281.8 1287.2 24340.4 26067.7 26125.2 26244.6 27195.9 40799.0 41191.8 41731.0 41731.2 41787.0 277001.0 278462.0 279869.0 280165.0 280284.0 20576.7 23085.9 23536.4 23555.1 24925.0 35385.1 35782.0 36059.5 36224.3 36580.0 32119.5 33451.8 33998.7 34810.7 35018.0 33598.7 34112.7 34161.8 34255.3 34327.3 33233.0 33870.5 34122.5 34233.5 34310.3 28144.6 28617.7 30100.4 30458.4 30830.7 23770.9 24023.9 24112.8 24138.8 24166.2 16:55:22 INFO - PROCESS | 21453 | 16:55:22 INFO - PROCESS | 21453 | [#2] jquery.html Cycles:180 Average:25267.96 Median:28268.61 stddev:70122.80 (248.1%) stddev-sans-first:70294.61 16:55:22 INFO - PROCESS | 21453 | Values: 378.6 378.7 387.7 389.3 393.1 16036.4 16760.3 17143.7 17472.4 17518.4 16425.8 16735.7 17013.3 17224.2 17227.3 5004.1 5180.5 5225.6 5228.4 5231.8 3709.6 3895.8 5789.8 6095.7 6099.9 5984.2 6039.3 6040.5 6065.5 6075.1 5856.4 5996.1 6006.2 6007.5 6012.6 3430.6 5093.0 5344.9 5351.2 5356.7 11750.8 12406.2 12409.4 19407.2 19451.6 1983.8 1998.9 2097.2 2138.0 2443.3 8765.0 9066.0 9114.6 9397.9 9660.9 1662.8 1726.6 1737.3 1764.2 1767.4 67778.7 67914.7 71221.3 71476.6 72810.4 9923.9 10066.4 10123.2 10154.7 10280.5 14464.9 14576.4 14591.0 14608.9 14624.6 6965.7 6998.5 7153.1 7329.5 7330.6 6672.4 6672.7 6757.9 6848.0 6849.0 4374.3 4420.6 4420.8 4438.5 4545.5 1717.5 1750.7 1819.9 1822.8 1863.6 391.0 913.4 915.7 986.3 1004.8 10240.4 16277.3 18357.6 18434.3 18819.5 834.7 875.3 875.7 885.6 908.9 9724.0 9803.5 9899.9 9909.7 10053.4 413110.0 415968.0 430732.0 431199.0 432494.0 82031.6 83188.0 84693.6 85974.6 86212.6 905.7 907.2 939.2 973.7 993.4 15449.7 15554.3 15567.8 15579.1 15678.5 31162.8 35073.0 35173.3 36008.6 36578.3 48516.3 50316.2 50682.2 51444.2 51541.7 7778.8 7940.6 7948.0 8063.4 8105.2 10482.0 11020.4 11472.7 11484.8 11631.7 9138.3 9462.7 9586.2 9605.5 9954.7 8806.2 9448.1 9913.6 9920.4 10607.7 9662.9 9812.5 9827.2 10268.0 10328.8 7562.6 7574.5 7801.5 7917.4 8002.0 8493.6 9741.4 10066.3 10076.8 10242.9 16:55:22 INFO - PROCESS | 21453 | 16:55:22 INFO - PROCESS | 21453 | [#3] mootools.html Cycles:180 Average:5020.42 Median:5061.25 stddev:2803.79 (55.4%) stddev-sans-first:2797.57 16:55:22 INFO - PROCESS | 21453 | Values: 1281.2 1440.6 1456.7 1565.5 1750.5 6689.9 7500.1 7667.8 7708.9 7719.5 7411.1 7578.9 7590.4 7595.8 7606.2 1892.9 2114.4 2205.5 2221.9 2251.7 2203.3 2219.3 2225.3 2227.9 2241.2 2112.0 2196.0 2199.3 2200.8 2203.4 1857.7 2163.2 2216.6 2218.0 2220.1 2123.0 2142.9 2148.1 2154.2 2163.4 7431.4 7520.1 7528.5 7531.2 7534.6 4431.9 4555.7 4581.6 4628.8 4633.5 2797.1 2797.8 2871.9 2909.8 2931.9 920.4 921.1 937.1 945.8 953.0 10126.1 10327.3 10334.8 10363.4 10363.9 4149.4 4191.5 4321.6 4324.5 4325.9 8916.2 8964.1 8986.5 8989.6 9002.8 4014.6 4646.3 4681.6 4697.3 4701.3 3948.4 4013.2 4029.2 4045.2 4067.5 3560.1 3590.6 3690.2 3719.4 3739.6 1108.3 1119.8 1125.6 1136.9 1152.7 779.5 805.0 813.8 835.6 839.2 4885.9 5012.8 5037.8 5084.7 5113.0 417.7 424.6 430.6 912.2 958.2 3289.7 3356.2 3390.2 3410.8 3442.9 9102.1 9459.8 9518.5 9579.1 9590.8 9318.8 9433.2 9437.9 9482.2 9487.8 6724.4 6774.3 7021.9 7067.5 7085.1 5349.5 5377.5 5458.4 5476.7 5527.3 8692.7 8789.0 8843.9 8879.4 8985.6 8780.3 8935.2 9021.1 9099.2 9129.3 5981.9 6137.5 6140.8 6717.1 6872.9 6463.8 6537.9 7025.2 7277.5 7281.0 6407.2 6491.3 6535.2 6549.5 6588.6 6467.1 6495.0 6618.9 6685.2 6689.8 6188.0 6237.0 6242.5 6258.8 6282.2 4217.3 4367.0 4564.4 4600.4 4633.9 4524.8 4563.4 4570.1 4616.8 4654.7 16:55:22 INFO - PROCESS | 21453 | 16:55:22 INFO - PROCESS | 21453 | [#4] prototype.html Cycles:180 Average:4339.83 Median:4826.72 stddev:1266.31 (26.2%) stddev-sans-first:1233.07 16:55:22 INFO - PROCESS | 21453 | Values: 302.2 303.8 305.9 315.8 321.1 4800.2 4860.5 4870.5 4874.3 4878.7 4785.0 4811.6 4819.3 4834.2 4837.3 3636.2 3709.7 3750.5 3803.7 3825.3 3775.5 3812.7 3837.3 3841.2 3846.9 3613.9 3806.6 3811.1 3822.8 3824.8 3650.4 3774.6 3777.9 3800.7 3808.2 3325.1 3350.8 3359.8 3377.4 3380.9 4614.5 4620.3 4620.8 4624.4 4637.8 4241.5 4259.3 4281.3 4322.5 4330.7 4966.5 4992.5 5012.2 5017.3 5035.5 3657.2 3664.7 3670.7 3674.4 3684.8 5031.5 5179.7 5285.2 5291.7 5296.2 3792.8 3799.2 3839.8 3844.0 3857.9 3852.0 3874.5 3881.8 3890.2 3899.2 4350.4 4358.2 4359.1 4371.3 4379.8 4762.9 5018.4 5039.5 5046.6 5060.8 1422.0 1422.1 1425.6 1429.1 1429.1 919.9 963.4 976.9 977.9 997.7 4632.2 4640.1 4648.7 4653.6 4687.1 5466.9 5468.9 5471.9 5500.4 5502.8 4254.3 4520.7 4663.6 4671.2 4685.6 2961.2 2962.8 2971.5 2982.6 2995.3 5227.6 5240.5 5246.4 5248.9 5265.3 5509.6 5670.8 5696.7 5709.9 5724.3 5195.6 5214.7 5228.9 5229.8 5251.7 5476.3 5584.2 5587.3 5602.0 5618.6 5373.6 5487.1 5489.2 5490.0 5511.7 5228.2 5263.6 5269.6 5275.0 5290.6 3838.3 3908.8 3926.8 3929.4 3933.4 5575.8 5597.2 5599.6 5599.7 5601.6 5371.8 5383.5 5396.6 5397.4 5398.2 5162.3 5359.2 5360.6 5388.9 5402.4 4675.3 5244.9 5279.8 5292.5 5307.9 4906.6 5061.8 5087.2 5100.6 5112.1 4959.3 4965.8 4972.6 5006.9 5015.5 16:55:22 INFO - PROCESS | 21453 | 16:55:22 INFO - PROCESS | 21453 | [#5] yui.html Cycles:180 Average:12081.54 Median:627.56 stddev:14320.41 (2281.9%) stddev-sans-first:14335.02 16:55:22 INFO - PROCESS | 21453 | Values: 686.9 711.4 731.4 733.3 738.6 10555.1 10786.2 10827.8 10850.1 10869.9 11162.4 11223.3 11226.3 11227.5 11230.9 620.4 760.6 792.4 795.1 795.6 770.7 774.7 777.2 777.5 778.2 656.7 824.6 829.4 830.0 830.3 669.9 671.7 800.0 830.8 832.6 610.3 610.5 610.5 611.0 611.1 10255.7 10331.5 10332.9 10342.9 10351.1 11063.8 11120.6 11249.7 11499.3 11635.5 9391.7 9600.3 9660.3 9676.8 9693.2 3227.5 3232.9 3251.5 3257.1 3302.6 43473.0 43557.1 43632.1 43691.8 43796.3 9172.7 9226.2 9426.2 9542.9 9581.9 16705.6 16862.3 16866.8 16886.6 16900.7 6352.8 6434.9 6459.5 6498.4 6546.7 3509.3 3586.9 3616.3 3632.3 3633.9 2667.9 2695.1 2716.2 2729.6 2732.6 497.4 498.1 506.1 513.7 516.5 459.6 641.8 648.8 653.4 656.6 7524.7 7718.3 7768.7 7799.6 7867.8 546.8 618.6 626.0 629.1 666.4 3685.5 3688.9 3756.2 3764.1 3793.4 50262.5 50958.2 52236.2 52608.5 52858.2 44258.7 46119.5 46357.5 46607.3 47867.8 41880.6 41983.8 42586.4 43116.4 44132.3 6996.6 7004.5 7051.1 7190.2 7279.2 29503.6 29996.4 30372.0 30436.2 30612.2 35397.5 37260.6 38331.0 38354.8 39652.0 9368.4 9431.4 9463.6 9499.0 9715.9 9830.3 9876.6 9930.9 9954.3 10081.7 8799.2 8949.3 8995.4 9106.1 9163.7 9235.9 9337.8 9364.8 9368.8 9564.3 8576.8 8707.5 8750.7 8761.3 8860.8 7519.2 7704.6 7801.6 7802.9 7959.6 7856.4 7919.4 8005.2 8176.0 8274.6 16:55:22 INFO - PROCESS | 21453 | -------- Summary: end -------- 16:55:22 INFO - PROCESS | 21453 | 16:55:23 INFO - TEST-INFO | 21453: exit 0 16:55:23 INFO - TEST-OK | dromaeo_css | took 1120698ms 16:55:23 INFO - TEST-START | kraken 16:55:23 INFO - operating with platform_type : linux_ 16:55:23 INFO - Initialising browser for kraken test... 16:55:23 INFO - TEST-INFO | started process 21626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJnU9s1/profile http://localhost:54989/getInfo.html) 16:55:28 INFO - PROCESS | 21626 | __metrics Screen width/height:1600/1200 16:55:28 INFO - PROCESS | 21626 | colorDepth:24 16:55:28 INFO - PROCESS | 21626 | Browser inner width/height: 1024/697 16:55:28 INFO - PROCESS | 21626 | __metrics 16:55:29 ERROR - PROCESS | 21626 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:55:30 INFO - TEST-INFO | 21626: exit 0 16:55:30 INFO - Browser initialized. 16:55:30 INFO - Running cycle 1/1 for kraken test... 16:55:30 INFO - TEST-INFO | started process 21707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJnU9s1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:42 INFO - PROCESS | 21707 | RSS: Main: 155553792 16:55:42 INFO - PROCESS | 21707 | 16:55:44 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54989/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:45 INFO - PROCESS | 21707 | RSS: Main: 210563072 16:55:45 INFO - PROCESS | 21707 | 16:55:48 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54989/tests/kraken/driver.html?testName=audio-dft) 16:55:49 INFO - PROCESS | 21707 | RSS: Main: 196415488 16:55:49 INFO - PROCESS | 21707 | 16:55:52 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54989/tests/kraken/driver.html?testName=audio-fft) 16:55:53 INFO - PROCESS | 21707 | RSS: Main: 266268672 16:55:53 INFO - PROCESS | 21707 | 16:55:55 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54989/tests/kraken/driver.html?testName=audio-oscillator) 16:55:55 INFO - PROCESS | 21707 | RSS: Main: 175009792 16:55:55 INFO - PROCESS | 21707 | 16:55:58 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:55:58 INFO - PROCESS | 21707 | RSS: Main: 180158464 16:55:58 INFO - PROCESS | 21707 | 16:56:01 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54989/tests/kraken/driver.html?testName=imaging-darkroom) 16:56:02 INFO - PROCESS | 21707 | RSS: Main: 215552000 16:56:02 INFO - PROCESS | 21707 | 16:56:05 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54989/tests/kraken/driver.html?testName=imaging-desaturate) 16:56:06 INFO - PROCESS | 21707 | RSS: Main: 216154112 16:56:06 INFO - PROCESS | 21707 | 16:56:09 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54989/tests/kraken/driver.html?testName=json-parse-financial) 16:56:09 INFO - PROCESS | 21707 | RSS: Main: 216412160 16:56:09 INFO - PROCESS | 21707 | 16:56:11 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:56:12 INFO - PROCESS | 21707 | RSS: Main: 202059776 16:56:12 INFO - PROCESS | 21707 | 16:56:14 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:56:14 INFO - PROCESS | 21707 | RSS: Main: 205643776 16:56:14 INFO - PROCESS | 21707 | 16:56:16 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:56:17 INFO - PROCESS | 21707 | RSS: Main: 218365952 16:56:17 INFO - PROCESS | 21707 | 16:56:20 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:56:20 INFO - PROCESS | 21707 | RSS: Main: 226140160 16:56:20 INFO - PROCESS | 21707 | 16:56:23 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:56:24 INFO - PROCESS | 21707 | RSS: Main: 222248960 16:56:24 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54989/tests/kraken/driver.html?testName=ai-astar) 16:56:26 INFO - PROCESS | 21707 | RSS: Main: 285593600 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | __start_tp_report 16:56:26 INFO - PROCESS | 21707 | _x_x_mozilla_page_load 16:56:26 INFO - PROCESS | 21707 | _x_x_mozilla_page_load_details 16:56:26 INFO - PROCESS | 21707 | |i|pagename|runs| 16:56:26 INFO - PROCESS | 21707 | |0;ai-astar;112;116;110;113;115;115;104;115;113;115 16:56:26 INFO - PROCESS | 21707 | |1;audio-beat-detection;164;132;155;186;127;163;156;136;192;132 16:56:26 INFO - PROCESS | 21707 | |2;audio-dft;162;160;161;160;167;161;161;162;162;160 16:56:26 INFO - PROCESS | 21707 | |3;audio-fft;74;77;103;107;85;74;73;124;103;73 16:56:26 INFO - PROCESS | 21707 | |4;audio-oscillator;94;95;149;94;94;93;151;94;94;152 16:56:26 INFO - PROCESS | 21707 | |5;imaging-gaussian-blur;117;117;117;116;118;118;117;117;116;117 16:56:26 INFO - PROCESS | 21707 | |6;imaging-darkroom;147;147;147;146;147;148;146;146;146;149 16:56:26 INFO - PROCESS | 21707 | |7;imaging-desaturate;95;94;95;95;94;95;95;94;94;94 16:56:26 INFO - PROCESS | 21707 | |8;json-parse-financial;63;64;64;63;64;64;64;82;62;62 16:56:26 INFO - PROCESS | 21707 | |9;json-stringify-tinderbox;64;64;64;65;65;65;64;65;64;64 16:56:26 INFO - PROCESS | 21707 | |10;stanford-crypto-aes;87;78;78;76;80;80;85;79;79;82 16:56:26 INFO - PROCESS | 21707 | |11;stanford-crypto-ccm;131;136;129;132;129;131;137;138;167;139 16:56:26 INFO - PROCESS | 21707 | |12;stanford-crypto-pbkdf2;176;175;171;173;172;173;170;171;172;171 16:56:26 INFO - PROCESS | 21707 | |13;stanford-crypto-sha256-iterative;74;73;76;72;71;72;80;70;73;72 16:56:26 INFO - PROCESS | 21707 | __end_tp_report 16:56:26 INFO - PROCESS | 21707 | __start_cc_report 16:56:26 INFO - PROCESS | 21707 | _x_x_mozilla_cycle_collect,1902 16:56:26 INFO - PROCESS | 21707 | __end_cc_report 16:56:26 INFO - PROCESS | 21707 | __startTimestamp1461887786510__endTimestamp 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | ------- Summary: start ------- 16:56:26 INFO - PROCESS | 21707 | Number of tests: 14 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#0] ai-astar Cycles:10 Average:112.80 Median:115.00 stddev:3.58 (3.1%) stddev-sans-first:3.79 16:56:26 INFO - PROCESS | 21707 | Values: 112.0 116.0 110.0 113.0 115.0 115.0 104.0 115.0 113.0 115.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:159.50 stddev:22.79 (14.3%) stddev-sans-first:23.90 16:56:26 INFO - PROCESS | 21707 | Values: 164.0 132.0 155.0 186.0 127.0 163.0 156.0 136.0 192.0 132.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:2.07 (1.3%) stddev-sans-first:2.19 16:56:26 INFO - PROCESS | 21707 | Values: 162.0 160.0 161.0 160.0 167.0 161.0 161.0 162.0 162.0 160.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#3] audio-fft Cycles:10 Average:89.30 Median:73.50 stddev:18.45 (25.1%) stddev-sans-first:18.71 16:56:26 INFO - PROCESS | 21707 | Values: 74.0 77.0 103.0 107.0 85.0 74.0 73.0 124.0 103.0 73.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:94.00 stddev:27.39 (29.1%) stddev-sans-first:28.35 16:56:26 INFO - PROCESS | 21707 | Values: 94.0 95.0 149.0 94.0 94.0 93.0 151.0 94.0 94.0 152.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 16:56:26 INFO - PROCESS | 21707 | Values: 117.0 117.0 117.0 116.0 118.0 118.0 117.0 117.0 116.0 117.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 16:56:26 INFO - PROCESS | 21707 | Values: 147.0 147.0 147.0 146.0 147.0 148.0 146.0 146.0 146.0 149.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 16:56:26 INFO - PROCESS | 21707 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.00 stddev:5.96 (9.3%) stddev-sans-first:6.27 16:56:26 INFO - PROCESS | 21707 | Values: 63.0 64.0 64.0 63.0 64.0 64.0 64.0 82.0 62.0 62.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 16:56:26 INFO - PROCESS | 21707 | Values: 64.0 64.0 64.0 65.0 65.0 65.0 64.0 65.0 64.0 64.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:3.37 (4.2%) stddev-sans-first:2.60 16:56:26 INFO - PROCESS | 21707 | Values: 87.0 78.0 78.0 76.0 80.0 80.0 85.0 79.0 79.0 82.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:136.50 stddev:11.21 (8.2%) stddev-sans-first:11.68 16:56:26 INFO - PROCESS | 21707 | Values: 131.0 136.0 129.0 132.0 129.0 131.0 137.0 138.0 167.0 139.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.50 stddev:1.90 (1.1%) stddev-sans-first:1.50 16:56:26 INFO - PROCESS | 21707 | Values: 176.0 175.0 171.0 173.0 172.0 173.0 170.0 171.0 172.0 171.0 16:56:26 INFO - PROCESS | 21707 | 16:56:26 INFO - PROCESS | 21707 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.00 stddev:2.87 (3.9%) stddev-sans-first:3.03 16:56:26 INFO - PROCESS | 21707 | Values: 74.0 73.0 76.0 72.0 71.0 72.0 80.0 70.0 73.0 72.0 16:56:26 INFO - PROCESS | 21707 | -------- Summary: end -------- 16:56:26 INFO - PROCESS | 21707 | 16:56:27 INFO - TEST-INFO | 21707: exit 0 16:56:27 INFO - TEST-OK | kraken | took 63945ms 16:56:27 INFO - SUITE-END | took 1184s 16:56:27 INFO - Completed test suite (00:19:44) 16:56:27 INFO - javascript benchmark 16:56:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.185351614242, 2670.37246247132, 2675.906343277986, 2685.825421347612, 2711.44415394844, 4498.167838949788, 4629.837955671552, 4641.675082744205, 4660.906781864365, 4672.345871577973, 4643.419572553431, 4650.116477869211, 4687.671862969593, 4703.08289883472, 4717.29240613908, 4312.805923733439, 4324.978375108128, 4355.934660980088, 4379.824807007732, 4423.823047078129, 4325.82696692132, 4361.847335343264, 4363.781810909458, 4371.759553224571, 4419.447569053868, 4208.22147902636, 4254.595813397722, 4272.829086836523, 4293.806778694935, 4340.544242854487, 4315.115401342718, 4344.413504176927, 4347.347897815322, 4348.456442944632, 4394.8461803837035, 4314.3528470729325, 4326.048269380732, 4327.459067616548, 4342.739435633872, 4373.540778218305, 4415.139047885664, 4492.438445194351, 4513.210188217082, 4641.976790116028, 4654.557817007379, 4929.926051109201, 4934.1611925972675, 4935.7532123393685, 4936.654434189608, 4960.355153830015, 4932.901341973176, 4945.406551213841, 4952.232403977389, 4958.826441074581, 5001.274815151819, 4524.434445694321, 4621.838235661736, 4663.510331415153, 4704.670673052853, 4710.599599034052, 5036.672616280003, 5064.215046667772, 5064.620153488503, 5069.087564238399, 5118.59051275897, 4772.594329482033, 4870.6103511718975, 4872.317875497433, 4877.756112194376, 4923.286123512143, 4967.354243948336, 5038.042771873333, 5049.545540901263, 5058.645894787403, 5060.089183946925, 4921.704697718077, 4925.827596034122, 4929.137400954819, 4935.062338155739, 4985.9501404985485, 4914.090893184701, 4916.754162291871, 4921.0, 4934.7285899275885, 4973.5523802857915, 4170.833166673299, 4231.026863821338, 4232.259354612992, 4233.5131459882505, 4236.364545318227, 3707.7775333480076, 3721.0511319613865, 3754.9249015019545, 3755.3615885299564, 3757.0, 4235.724677895927, 4251.256030194765, 4302.913087152729, 4348.239058164809, 4349.913001740011, 4926.45808961014, 4944.48082951285, 4947.851564453073, 4955.603551715854, 5000.224965130411, 4148.91702165955, 4254.914901701949, 4257.3613957905945, 4258.148370325947, 4299.097189590158, 4425.137098265872, 4425.269830478, 4451.198784218807, 4490.708103973231, 4508.1659892919915, 4691.366665500251, 4691.788869500812, 4695.3426520287185, 4701.106789709944, 4732.550407711331, 4760.190767569591, 4845.1520983828395, 4973.378327709036, 4980.950190498049, 5020.397552293748, 4700.858974230779, 4718.386609740712, 4730.314104454904, 4731.195696731495, 4770.284457331428, 4921.581665558468, 4927.334809800631, 4927.9507204927495, 4928.630352723631, 4959.57843583285, 4848.80604775805, 4995.575376093073, 5005.074061298671, 5037.1688671370275, 5043.142665746906, 4820.638452116035, 4825.758712064313, 4838.661293709407, 4860.635452341018, 4888.6577939543895, 4823.493533178966, 4832.927506087482, 4834.057358814997, 4837.903241935212, 4882.121218180761, 4650.37219975299, 4720.787564559534, 4759.262314341283, 4778.665493415428, 4797.56821886032, 4774.689645173053, 4795.976020119877, 4799.736014519235, 4839.491853355347, 4844.95155048445, 4696.600788932842, 4707.505711900338, 4717.410323709536, 4720.291956206596, 4749.382580264543], "value": 4569.853529567565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.1674380520147, 596.0731063196728, 603.3574243430746, 624.7938180400463, 625.3027873920579, 34340.0, 36102.81948590253, 36198.45702314467, 36243.637563624354, 36254.643448175884, 37511.81244093783, 38270.23459530808, 38297.0, 38316.80841595788, 38382.61617383832, 7332.0468339116105, 7542.132654744692, 7667.079950405959, 7870.881936770953, 9634.47010414427, 9775.657851975182, 9945.254105942084, 9945.602175912954, 9946.0, 9946.403215807075, 9913.0, 10049.748756281078, 10051.195904327673, 10059.0, 10060.899391006105, 7209.495335326529, 9560.952195239013, 9853.162481189036, 9853.802923941552, 9858.0, 9761.267904907088, 9908.058734420218, 9909.653162139362, 9911.603535858629, 9912.752181195456, 34975.475367869505, 35624.28751424983, 35624.821875890455, 35685.64314356875, 35709.28581428357, 3087.336222712128, 3098.7056229658147, 3128.03031060372, 3322.2358857462677, 3734.551853777537, 27957.580636290473, 28159.0, 28668.71331286702, 28806.42387152266, 29572.55641165384, 3280.114369120348, 3302.290007648343, 3328.5007248912616, 3332.983335083309, 3407.267437500924, 173898.0, 174202.0, 175269.0, 176730.0, 233013.0, 51400.74299628478, 51599.74200128976, 51669.48330516722, 51789.48210517847, 51885.740571296905, 50289.0, 51290.48709512932, 51690.0, 51696.22455663168, 51703.74148129235, 12534.749305014031, 14504.927475362767, 14793.112413255023, 14793.778093328609, 14796.038257513228, 10128.088472037552, 10408.219383546264, 10421.218408619385, 10422.843657345145, 10510.054095131474, 17672.204750786244, 17704.203310850786, 17747.378841740734, 17946.19242134107, 17994.91002544979, 6792.286809884989, 6825.010373495816, 6934.930650693529, 6946.9652651736415, 7120.181179164359, 919.131420807344, 924.8381533231658, 938.2072149034055, 961.423146112327, 980.8724865767405, 27186.0, 28215.0, 28598.85700571484, 28907.132786016453, 29080.127596172148, 1003.508280942333, 1011.3224139826187, 1017.1710056304237, 1044.300318786415, 1059.3008614314515, 14047.438102475786, 14614.0, 14941.775873361908, 15063.849361506464, 15467.767983480257, 347933.0, 356518.0, 357212.0, 358407.0, 359201.0, 50990.235146472834, 51618.22572661413, 51664.48335516672, 51701.0, 51795.0, 1126.3523474002482, 1155.5608868629868, 1236.9628911132681, 1281.833361662978, 1287.1890708853362, 24340.391490212885, 26067.723155887263, 26125.216243512725, 26244.60633090467, 27195.864020679768, 40799.0, 41191.7940410296, 41731.0, 41731.1653766929, 41787.0, 277001.0, 278462.0, 279869.0, 280165.0, 280284.0, 20576.69134962947, 23085.88457057704, 23536.411589710395, 23555.0577976879, 24925.0, 35385.115372115906, 35782.0, 36059.459108112875, 36224.27551449009, 36580.0, 32119.51820722738, 33451.83274083614, 33998.66001339955, 34810.65189348074, 35018.0, 33598.66401335955, 34112.65887341095, 34161.82919085389, 34255.314893701485, 34327.31345373129, 33233.0, 33870.491942621375, 34122.48816267708, 34233.486497702055, 34310.31379372448, 28144.577831332135, 28617.713822862337, 30100.397992040474, 30458.390832183675, 30830.691693082783, 23770.88114559416, 24023.879880600485, 24112.75887241105, 24138.75861241365, 24166.154184603456], "value": 17321.7649643464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.63165897312314, 378.6573151298076, 387.71309231168937, 389.30897656659425, 393.119412515964, 16036.358545658175, 16760.32958681651, 17143.742843857337, 17472.388466403678, 17518.38685646001, 16425.753613695804, 16735.66528669429, 17013.273787371294, 17224.224909879053, 17227.310907563682, 5004.074246264435, 5180.481951804827, 5225.634205605609, 5228.424873263938, 5231.843044708665, 3709.6290370962956, 3895.824687889052, 5789.8263052108505, 6095.6952152392205, 6099.878002439948, 5984.162217289583, 6039.275286965549, 6040.516758659297, 6065.454109130177, 6075.088736689488, 5856.355800861902, 5996.13056106862, 6006.21919150512, 6007.549433792461, 6012.609180403281, 3430.588329400463, 5093.0, 5344.931013797217, 5351.224072509464, 5356.7321633918145, 11750.823737643943, 12406.193597416139, 12409.44157512905, 19407.22371105154, 19451.610967780707, 1983.7547648033221, 1998.860079794415, 2097.1820989813987, 2138.0058272903175, 2443.2670198940423, 8765.0, 9065.954670226607, 9114.635414583408, 9397.906020939772, 9660.90339096607, 1662.8337166283395, 1726.6374061447111, 1737.313761064385, 1764.2325588369101, 1767.3902503636225, 67778.66110669416, 67914.66042669804, 71221.28778712198, 71476.64261678659, 72810.44705976488, 9923.851142232872, 10066.396016239049, 10123.1901447884, 10154.746131346776, 10280.537375818107, 14464.855351446562, 14576.416943322149, 14591.0, 14608.853911460961, 14624.634384140269, 6965.721371145098, 6998.545094568837, 7153.105861767279, 7329.486935914435, 7330.5968171751065, 6672.366125218096, 6672.733090676318, 6757.8648427031185, 6848.0, 6849.006894000442, 4374.300111982067, 4420.624246939046, 4420.778961051935, 4438.511763705989, 4545.477270113913, 1717.527679888041, 1750.7286370612576, 1819.945401637953, 1822.7557813681562, 1863.5620629152138, 390.9843606255775, 913.397157875812, 915.66120535401, 986.2652324018652, 1004.7689031522791, 10240.439890027494, 16277.348906043626, 18357.63284734298, 18434.26262949467, 18819.52507119943, 834.7386591450678, 875.28664138728, 875.6978842299396, 885.588201486312, 908.9227415669742, 9723.951380243196, 9803.460809655395, 9899.851502227473, 9909.653162139435, 10053.447060411601, 413110.0, 415968.0, 430732.0, 431199.0, 432494.0, 82031.58984205041, 83188.0, 84693.57653211818, 85974.57012714897, 86212.56893715616, 905.7192270396198, 907.1744712311896, 939.154760715348, 973.7127547373542, 993.3692105512907, 15449.691006180039, 15554.300056497259, 15567.84432155664, 15579.143147127017, 15678.451254206047, 31162.844185778926, 35073.0, 35173.29653406969, 36008.63991360053, 36578.26843463063, 48516.272255915486, 50316.24525632192, 50682.239766402796, 51444.22833657423, 51541.742291289804, 7778.844423111619, 7940.642671079931, 7948.0, 8063.35493160534, 8105.230003149692, 10482.004209600076, 11020.393878336448, 11472.655820325404, 11484.770304593694, 11631.709207269885, 9138.268938485038, 9462.668806591737, 9586.185174260267, 9605.519724013631, 9954.651587194414, 8806.20744133031, 9448.149666530046, 9913.553890075109, 9920.355176913477, 10607.681769546925, 9662.855057174007, 9812.460314682761, 9827.213822894008, 10268.0, 10328.845067324146, 7562.621868906643, 7574.469787114849, 7801.503518873906, 7917.445778795429, 8002.03975522941, 8493.617787199468, 9741.415515069119, 10066.295359324777, 10076.84884726715, 10242.897571024492], "value": 8186.58164876651, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.1864466064058, 1440.5750303660423, 1456.7086582683462, 1565.5225156327322, 1750.457358218953, 6689.866202675944, 7500.099988001441, 7667.846643067135, 7708.884366734504, 7719.45963782534, 7411.110666719987, 7578.924210757905, 7590.392768578514, 7595.810104747384, 7606.201348858373, 1892.858035647332, 2114.4291041418805, 2205.52581195043, 2221.855579387339, 2251.6735073414343, 2203.2619072610696, 2219.323106452531, 2225.2879078694823, 2227.9108835646634, 2241.170766816272, 2111.9894400527974, 2196.02276986741, 2199.285232299509, 2200.8129309008755, 2203.3720389688942, 1857.7120546315275, 2163.1888041984257, 2216.556688662258, 2217.968644580278, 2220.0564759977105, 2123.0446299165283, 2142.924997625076, 2148.140743702516, 2154.2029449103934, 2163.3618082665653, 7431.368333691643, 7520.097588289385, 7528.510646807995, 7531.246875312425, 7534.623268836536, 4431.8670439886855, 4555.658325625558, 4581.5647513486165, 4628.768561571908, 4633.536646335373, 2797.132888804457, 2797.7901657375573, 2871.9425611487864, 2909.7817663675096, 2931.897383591564, 920.3557509743207, 921.1249313152465, 937.0582564522612, 945.7588314979705, 952.9666461673877, 10126.088652021353, 10327.27709060366, 10334.844977325347, 10363.430011349374, 10363.948180259125, 4149.398337241144, 4191.497020357577, 4321.58944900234, 4324.524302326741, 4325.9134817303475, 8916.197542221102, 8964.058773828785, 8986.460812351279, 8989.55052247385, 9002.819943601222, 4014.578469260686, 4646.25659894422, 4681.625469962395, 4697.342372067913, 4701.318308845198, 3948.447217389568, 4013.177298653827, 4029.2143032108456, 4045.150518391171, 4067.471228740304, 3560.0743806610467, 3590.551181102362, 3690.151265209017, 3719.386301260262, 3739.5512538495555, 1108.2519299472824, 1119.7816425797055, 1125.5835340923747, 1136.8863113688565, 1152.706059954723, 779.5128044971892, 804.9597520123971, 813.808754942588, 835.603088532942, 839.2321026261025, 4885.853424397203, 5012.7994880205115, 5037.798488060436, 5084.694918304914, 5113.028524580318, 417.7076046767275, 424.5584592024322, 430.59093860831706, 912.2245047178018, 958.2382006305004, 3289.671032896691, 3356.1945133167865, 3390.1863552747654, 3410.8294585270637, 3442.9311413772084, 9102.089791020977, 9459.810803783887, 9518.524073796283, 9579.13787759105, 9590.808183836285, 9318.767030824283, 9433.245340372754, 9437.858432123523, 9482.241420686329, 9487.76280592977, 6724.394804467622, 6774.254831968479, 7021.859562808715, 7067.5052746307265, 7085.14978202619, 5349.514950696678, 5377.462253774591, 5458.399576046552, 5476.67139971587, 5527.2538207341495, 8692.695755648521, 8789.0, 8843.867341989746, 8879.422837515542, 8985.550722463982, 8780.341474389319, 8935.195832375117, 9021.097890210927, 9099.1810737034, 9129.269658427444, 5981.880362392641, 6137.539684523768, 6140.846478838065, 6717.126773519607, 6872.862542749217, 6463.806085817433, 6537.8692426150255, 7025.192102908231, 7277.526960747535, 7280.96359518199, 6407.199100112486, 6491.253505846699, 6535.215774107138, 6549.541532092708, 6588.571742836701, 6467.126937863328, 6495.021972838172, 6618.90071648916, 6685.164354455693, 6689.76585819494, 6188.0, 6236.968815155895, 6242.531810114168, 6258.780942666985, 6282.246130464374, 4217.261979153697, 4367.0, 4564.360989461412, 4600.378948841863, 4633.907321853611, 4524.751138687404, 4563.3839431677625, 4570.131674981742, 4616.792244348945, 4654.697444666222], "value": 4030.3190224336986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.1991721936867, 303.7645824486024, 305.9174023013786, 315.79631137916044, 321.14575229888493, 4800.159972004898, 4860.513948605142, 4870.464248932623, 4874.317595536628, 4878.658493905424, 4784.952150478494, 4811.566958973692, 4819.25301578255, 4834.178189707749, 4837.298591704201, 3636.2000359920908, 3709.7032237421076, 3750.5311836020496, 3803.7147213958924, 3825.3114439400897, 3775.5469343678797, 3812.7331086823797, 3837.270918525471, 3841.19334939663, 3846.8653597124107, 3613.8735144269954, 3806.5622453417795, 3811.1234416084317, 3822.847086116552, 3824.8087595620245, 3650.4341827016856, 3774.584795672474, 3777.886663400075, 3800.695944324475, 3808.1622043150464, 3325.1354647791504, 3350.832458377096, 3359.798412095282, 3377.375185590649, 3380.915477113067, 4614.469336026366, 4620.306953956933, 4620.768961551909, 4624.44506659203, 4637.791299391535, 4241.4698162729655, 4259.297215959363, 4281.272183728774, 4322.530339684491, 4330.722436881128, 4966.50334966504, 4992.500749925015, 5012.248162775576, 5017.2724954881705, 5035.496450354972, 3657.1771351445977, 3664.72514561409, 3670.687991520724, 3674.412094064937, 3684.7574134761508, 5031.496850314939, 5179.663321884065, 5285.207218917155, 5291.735413229323, 5296.205569164617, 3792.7913964732206, 3799.2401519696173, 3839.8080095995088, 3843.9807800960816, 3857.864974725871, 3851.9807400963377, 3874.49631547897, 3881.7865017424315, 3890.16361482277, 3899.2396482685604, 4350.412694286231, 4358.237308471005, 4359.106383191438, 4371.30059190528, 4379.759113248738, 4762.880927976828, 5018.42288136869, 5039.546440820343, 5046.646734728607, 5060.797568097235, 1421.978670319946, 1422.0756508269708, 1425.5580769961139, 1429.0925262458413, 1429.1496559547054, 919.9448033118034, 963.3689933093834, 976.8534719791946, 977.8875429325576, 997.7006897930592, 4632.2125238709505, 4640.11837750833, 4648.744319062416, 4653.581177694024, 4687.086018226413, 5466.9179962300595, 5468.863278418072, 5471.945280547144, 5500.367457742411, 5502.8349149525575, 4254.256004876899, 4520.706154099973, 4663.603593694574, 4671.229247174178, 4685.648576356787, 2961.1560705198913, 2962.837043962603, 2971.539411391238, 2982.568367183764, 2995.341024974502, 5227.581793456515, 5240.480260724347, 5246.3704355477585, 5248.895022099613, 5265.262863199156, 5509.559235261169, 5670.7731690732735, 5696.743646535916, 5709.914351284734, 5724.341700704473, 5195.584353251731, 5214.687118772886, 5228.90843662538, 5229.764660590283, 5251.71115588631, 5476.342838859362, 5584.162375643686, 5587.273654424899, 5602.0, 5618.550515958796, 5373.570114390761, 5487.149491828773, 5489.204065410413, 5490.0, 5511.696856672921, 5228.189630607262, 5263.578913686973, 5269.631125821155, 5274.97362513185, 5290.550303224269, 3838.2515409495995, 3908.8436462542318, 3926.7643941362467, 3929.390944403622, 3933.370660694275, 5575.804846830341, 5597.216389705526, 5599.580031497572, 5599.692016939108, 5601.60788744784, 5371.785128594813, 5383.5423988961375, 5396.568274538106, 5397.406285308534, 5398.163284690879, 5162.251473536241, 5359.196120581944, 5360.571154307724, 5388.946110538845, 5402.378726446352, 4675.298705194112, 5244.921326180187, 5279.841604751864, 5292.52367286946, 5307.85032062, 4906.6320025997475, 5061.848144555669, 5087.160618498055, 5100.591952643706, 5112.130937740519, 4959.305697202322, 4965.8013679452415, 4972.552470277547, 5006.874828129326, 5015.548600625962], "value": 3948.327205261455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.9450443964483, 711.3810984443535, 731.4221764805803, 733.3436574266032, 738.634375983888, 10555.050045495904, 10786.244962852603, 10827.83758243625, 10850.131989440846, 10869.891301086996, 11162.386068766215, 11223.326600403982, 11226.32642041478, 11227.494762735676, 11230.887691123085, 620.3517324396017, 760.6006846405626, 792.4492477727981, 795.0896223823719, 795.594246934062, 770.6840195519839, 774.7482068327788, 777.2499537945881, 777.4713195027379, 778.206229645761, 656.7471523463453, 824.6083110522513, 829.4069740135802, 830.016430529821, 830.2859540794942, 669.8961660942562, 671.6775947545157, 799.9600019998977, 830.8379865926147, 832.6419639554989, 610.2920612089998, 610.4597431273311, 610.4688920639072, 610.963342199465, 611.0681211153027, 10255.7436064099, 10331.535080921376, 10332.896671033268, 10342.896571034269, 10351.068403843616, 11063.778724425467, 11120.61077862271, 11249.718757031058, 11499.310041397543, 11635.476403561861, 9391.671291504832, 9600.279979001532, 9660.323777335589, 9676.75808104796, 9693.22454203662, 3227.5481432599454, 3232.9030129096163, 3251.4960181171955, 3257.120577444077, 3302.554155189043, 43473.0, 43557.12885742299, 43632.12735745299, 43691.78154109241, 43796.3430548542, 9172.72481825533, 9226.169644732006, 9426.151646351862, 9542.856857147148, 9581.898081720552, 16705.582360440843, 16862.325506979585, 16866.83133168677, 16886.57783555421, 16900.746488802677, 6352.809415717536, 6434.903476447857, 6459.450946669585, 6498.415142637185, 6546.70539825709, 3509.280597477511, 3586.9282614347567, 3616.349057169735, 3632.2735452909524, 3633.927321453609, 2667.933301667435, 2695.0702007807276, 2716.2394529531366, 2729.5769155780886, 2732.5764506501523, 497.38572862514764, 498.12330298674595, 506.12187854073153, 513.6943518606423, 516.4989959739047, 459.55652795052936, 641.7817941899776, 648.7761722205831, 653.4249860123061, 656.6158797103748, 7524.661390237453, 7718.343940765098, 7768.689252429953, 7799.649015794303, 7867.842643147105, 546.7539607176707, 618.6195489773756, 626.029654036242, 629.087822657149, 666.3869240298936, 3685.4656074868994, 3688.870889518854, 3756.154865155318, 3764.0589852536864, 3793.430985352164, 50262.49737502651, 50958.235626465634, 52236.21645675318, 52608.47391526112, 52858.207126893125, 44258.68059895521, 46119.538804612195, 46357.536424636, 46607.30089048667, 47867.76066119647, 41880.58119418767, 41983.790081049396, 42586.361204581335, 43116.35325470121, 44132.3380149298, 6996.580205187502, 7004.509684322048, 7051.1186101737285, 7190.20907700163, 7279.162896266997, 29503.55744663789, 29996.400071998873, 30372.0, 30436.239094022825, 30612.234694132825, 35397.469037963936, 37260.6273937268, 38331.04172395601, 38354.80822595869, 39652.0, 9368.4378937264, 9431.434113953184, 9463.574139163891, 9499.0, 9715.854262185932, 9830.311878168746, 9876.604935802774, 9930.900690992998, 9954.303198776306, 10081.747956301151, 8799.164079412445, 8949.32880033987, 8995.415298005608, 9106.089391061107, 9163.725088247364, 9235.861462078208, 9337.813243734952, 9364.765880853032, 9368.81262374735, 9564.282678799256, 8576.828463430822, 8707.47755134694, 8750.737477875675, 8761.299096072426, 8860.778480538038, 7519.210482899435, 7704.614769261627, 7801.570913599579, 7802.882956755767, 7959.602019899097, 7856.37149028065, 7919.406044546798, 8005.1594582568, 8175.959120204361, 8274.627641756015], "value": 5543.681479788796, "unit": "score"}], "name": "dromaeo_css", "value": 6206.777962479144, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 110.0, 113.0, 115.0, 115.0, 104.0, 115.0, 113.0, 115.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 155.0, 186.0, 127.0, 163.0, 156.0, 136.0, 192.0, 132.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 160.0, 167.0, 161.0, 161.0, 162.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 103.0, 107.0, 85.0, 74.0, 73.0, 124.0, 103.0, 73.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 149.0, 94.0, 94.0, 93.0, 151.0, 94.0, 94.0, 152.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 149.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 82.0, 62.0, 62.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 78.0, 78.0, 76.0, 80.0, 80.0, 85.0, 79.0, 79.0, 82.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 136.0, 129.0, 132.0, 129.0, 131.0, 137.0, 138.0, 167.0, 139.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 171.0, 173.0, 172.0, 173.0, 170.0, 171.0, 172.0, 171.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 72.0, 71.0, 72.0, 80.0, 70.0, 73.0, 72.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1580.0000000000002, "alertThreshold": 2.0}]} 16:56:27 INFO - Return code: 0 16:56:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:56:27 ERROR - # TBPL SUCCESS # 16:56:27 INFO - Running post-action listener: _resource_record_post_action 16:56:27 INFO - Running post-run listener: _resource_record_post_run 16:56:28 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 519122944; Read time: 0; Write time: 930092 16:56:28 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 234696704; Read time: 0; Write time: 635848 16:56:28 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 284372992; Read time: 0; Write time: 294224 16:56:28 INFO - Running post-run listener: _upload_blobber_files 16:56:28 INFO - Blob upload gear active. 16:56:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:56:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:56:28 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:56:28 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:56:29 INFO - (blobuploader) - INFO - Open directory for files ... 16:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:56:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:30 INFO - (blobuploader) - INFO - Done attempting. 16:56:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:56:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:56:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:31 INFO - (blobuploader) - INFO - Done attempting. 16:56:31 INFO - (blobuploader) - INFO - Iteration through files over. 16:56:31 INFO - Return code: 0 16:56:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:56:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:56:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1cbac2deb326583ee641aefa0aa42ae837ce9f47e55287e46be3019af4c45a4535026a12003897fd54fd0d636f4424efbcc023a8a47c2bdb5e12bc728ab1e0b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1df2f9238bc03ddf73f1e5e99359636405fd0015ae8354eed0b4a0bb7cc22d2f51e33ccbdb0f00c77a7937e2a976f3bd0f4e2f434825cb26e43f49923d6bd84"} 16:56:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:56:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:56:31 INFO - Contents: 16:56:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1cbac2deb326583ee641aefa0aa42ae837ce9f47e55287e46be3019af4c45a4535026a12003897fd54fd0d636f4424efbcc023a8a47c2bdb5e12bc728ab1e0b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1df2f9238bc03ddf73f1e5e99359636405fd0015ae8354eed0b4a0bb7cc22d2f51e33ccbdb0f00c77a7937e2a976f3bd0f4e2f434825cb26e43f49923d6bd84"} 16:56:31 INFO - Running post-run listener: copy_logs_to_upload_dir 16:56:31 INFO - Copying logs to upload dir... 16:56:31 INFO - mkdir: /builds/slave/test/build/upload/logs 16:56:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.723539 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-28 16:56:30.460632) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 16:56:30.468178) ========= 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=af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1cbac2deb326583ee641aefa0aa42ae837ce9f47e55287e46be3019af4c45a4535026a12003897fd54fd0d636f4424efbcc023a8a47c2bdb5e12bc728ab1e0b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1df2f9238bc03ddf73f1e5e99359636405fd0015ae8354eed0b4a0bb7cc22d2f51e33ccbdb0f00c77a7937e2a976f3bd0f4e2f434825cb26e43f49923d6bd84"} build_url:https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/VpxYTODPSHeOl5HtJwenGg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1cbac2deb326583ee641aefa0aa42ae837ce9f47e55287e46be3019af4c45a4535026a12003897fd54fd0d636f4424efbcc023a8a47c2bdb5e12bc728ab1e0b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1df2f9238bc03ddf73f1e5e99359636405fd0015ae8354eed0b4a0bb7cc22d2f51e33ccbdb0f00c77a7937e2a976f3bd0f4e2f434825cb26e43f49923d6bd84"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 16:56:30.495839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:56:30.496244) ========= 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=af724c981e2a0f424dbabf99000001e7-1461886207.882251-1643688475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004314 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 16:56:30.575519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 16:56:30.578904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 16:56:30.579716) ========= ========= Total master_lag: 0.18 =========