builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1462091852.78 results: success (0) buildid: 20160501005842 builduid: 47252016db0a4fa9acd42ee5bbe3714d revision: 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:32.778087) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:32.778594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:32.778935) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:32.838193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:32.838897) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-01 01:37:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.9M=0s 2016-05-01 01:37:33 (32.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080222 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:32.945444) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:32.945781) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019865 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:33.016518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:33.017155) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 --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 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 --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=4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-01 01:37:33,392 truncating revision to first 12 chars 2016-05-01 01:37:33,392 Setting DEBUG logging. 2016-05-01 01:37:33,392 attempt 1/10 2016-05-01 01:37:33,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7e4ac3f24fa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-01 01:37:33,907 unpacking tar archive at: fx-team-7e4ac3f24fa8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.824775 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:33.866781) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:33.867128) ========= script_repo_revision: 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:33.867593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:33.867892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 01:37:33.884541) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-01 01:37:33.884854) ========= /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=4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:37:34 INFO - MultiFileLogger online at 20160501 01:37:34 in /builds/slave/test 01:37:34 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 01:37:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:37:34 INFO - {'append_to_log': False, 01:37:34 INFO - 'base_work_dir': '/builds/slave/test', 01:37:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:37:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:37:34 INFO - 'branch': 'Fx-Team-Non-PGO', 01:37:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:37:34 INFO - 'config_files': ('talos/linux_config.py',), 01:37:34 INFO - 'default_actions': ('clobber', 01:37:34 INFO - 'read-buildbot-config', 01:37:34 INFO - 'download-and-extract', 01:37:34 INFO - 'populate-webroot', 01:37:34 INFO - 'create-virtualenv', 01:37:34 INFO - 'install', 01:37:34 INFO - 'run-tests'), 01:37:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:37:34 INFO - 'download_minidump_stackwalk': True, 01:37:34 INFO - 'download_symbols': 'ondemand', 01:37:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:37:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:37:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:37:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:37:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:37:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:37:34 INFO - 'installer_path': 'installer.exe', 01:37:34 INFO - 'log_level': 'info', 01:37:34 INFO - 'log_name': 'talos', 01:37:34 INFO - 'log_to_console': True, 01:37:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:37:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:37:34 INFO - 'opt_config_files': (), 01:37:34 INFO - 'pip_index': False, 01:37:34 INFO - 'sps_profile': False, 01:37:34 INFO - 'sps_profile_interval': 0, 01:37:34 INFO - 'suite': 'dromaeojs', 01:37:34 INFO - 'system_bits': '32', 01:37:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:37:34 INFO - 'title': 'talos-linux64-ix-030', 01:37:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:37:34 INFO - 'use_talos_json': True, 01:37:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:37:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:37:34 INFO - 'work_dir': 'build'} 01:37:34 INFO - ##### 01:37:34 INFO - ##### Running clobber step. 01:37:34 INFO - ##### 01:37:34 INFO - Running pre-action listener: _resource_record_pre_action 01:37:34 INFO - Running main action method: clobber 01:37:34 INFO - rmtree: /builds/slave/test/build 01:37:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:37:34 INFO - Running post-action listener: _resource_record_post_action 01:37:34 INFO - ##### 01:37:34 INFO - ##### Running read-buildbot-config step. 01:37:34 INFO - ##### 01:37:34 INFO - Running pre-action listener: _resource_record_pre_action 01:37:34 INFO - Running main action method: read_buildbot_config 01:37:34 INFO - Using buildbot properties: 01:37:34 INFO - { 01:37:34 INFO - "project": "", 01:37:34 INFO - "product": "firefox", 01:37:34 INFO - "script_repo_revision": "production", 01:37:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:37:34 INFO - "repository": "", 01:37:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:37:34 INFO - "buildid": "20160501005842", 01:37:34 INFO - "pgo_build": "False", 01:37:34 INFO - "basedir": "/builds/slave/test", 01:37:34 INFO - "buildnumber": 1627, 01:37:34 INFO - "slavename": "talos-linux64-ix-030", 01:37:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:37:34 INFO - "platform": "ubuntu64_hw", 01:37:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:37:34 INFO - "branch": "fx-team", 01:37:34 INFO - "repo_path": "integration/fx-team", 01:37:34 INFO - "revision": "7e4ac3f24fa87986c044d9ee13c1cf557ea55d07", 01:37:34 INFO - "stage_platform": "linux64", 01:37:34 INFO - "builduid": "47252016db0a4fa9acd42ee5bbe3714d", 01:37:34 INFO - "slavebuilddir": "test" 01:37:34 INFO - } 01:37:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:37:34 INFO - Running post-action listener: _resource_record_post_action 01:37:34 INFO - ##### 01:37:34 INFO - ##### Running download-and-extract step. 01:37:34 INFO - ##### 01:37:34 INFO - Running pre-action listener: _resource_record_pre_action 01:37:34 INFO - Running main action method: download_and_extract 01:37:34 INFO - mkdir: /builds/slave/test/build/tests 01:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:34 INFO - https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:37:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:37:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:37:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:37:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:37:39 INFO - Downloaded 1361 bytes. 01:37:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:37:39 INFO - Using the following test package requirements: 01:37:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:37:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:37:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:37:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:39 INFO - u'jsshell-linux-x86_64.zip'], 01:37:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:37:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:37:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:37:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:37:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:37:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:37:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:39 INFO - https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:37:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:37:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:37:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:37:46 INFO - Downloaded 22304506 bytes. 01:37:46 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'] 01:37:46 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 01:37:47 INFO - Return code: 0 01:37:47 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 01:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:47 INFO - https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:37:55 INFO - Downloaded 22304506 bytes. 01:37:55 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'] 01:37:55 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 01:37:57 INFO - Return code: 0 01:37: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')]} 01:37:57 INFO - https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:37:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:37:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:37:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:37:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:37:58 INFO - Downloaded 10840152 bytes. 01:37: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'] 01:37: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 01:37:58 INFO - Return code: 0 01:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:58 INFO - https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:37:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:37:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:37:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:37:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjVRBxphRGeTip82n_QhHQ/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 01:38:00 INFO - Downloaded 54909265 bytes. 01:38:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:38:00 INFO - mkdir: /builds/slave/test/properties 01:38:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:38:00 INFO - Writing to file /builds/slave/test/properties/build_url 01:38:00 INFO - Contents: 01:38:00 INFO - build_url:https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:38:01 INFO - Running post-action listener: _resource_record_post_action 01:38:01 INFO - Running post-action listener: set_extra_try_arguments 01:38:01 INFO - ##### 01:38:01 INFO - ##### Running populate-webroot step. 01:38:01 INFO - ##### 01:38:01 INFO - Running pre-action listener: _resource_record_pre_action 01:38:01 INFO - Running main action method: populate_webroot 01:38:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:38:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:38:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:38:01 INFO - '--tppagecycles', 01:38:01 INFO - '7'], 01:38:01 INFO - 'tests': ['tsvgm']}}, 01:38:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:38:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:38:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:38:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:38:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:01 INFO - 'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:01 INFO - 'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['damp', 'tps']}, 01:38:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:01 INFO - 'tests': ['damp', 'tps']}, 01:38:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['dromaeo_dom']}, 01:38:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:38:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['a11yr', 01:38:01 INFO - 'ts_paint', 01:38:01 INFO - 'tpaint', 01:38:01 INFO - 'sessionrestore', 01:38:01 INFO - 'sessionrestore_no_auto_restore', 01:38:01 INFO - 'tabpaint']}, 01:38:01 INFO - 'other-e10s': {'tests': ['a11yr', 01:38:01 INFO - 'ts_paint', 01:38:01 INFO - 'tpaint', 01:38:01 INFO - 'sessionrestore', 01:38:01 INFO - 'sessionrestore_no_auto_restore', 01:38:01 INFO - 'tabpaint']}, 01:38:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:38:01 INFO - 'ts_paint', 01:38:01 INFO - 'tpaint', 01:38:01 INFO - 'sessionrestore', 01:38:01 INFO - 'sessionrestore_no_auto_restore', 01:38:01 INFO - 'tabpaint']}, 01:38:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:38:01 INFO - 'ts_paint', 01:38:01 INFO - 'tpaint', 01:38:01 INFO - 'sessionrestore', 01:38:01 INFO - 'sessionrestore_no_auto_restore', 01:38:01 INFO - 'tabpaint']}, 01:38:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['a11yr', 01:38:01 INFO - 'ts_paint', 01:38:01 INFO - 'tpaint', 01:38:01 INFO - 'sessionrestore', 01:38:01 INFO - 'sessionrestore_no_auto_restore', 01:38:01 INFO - 'tabpaint']}, 01:38:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['a11yr', 01:38:01 INFO - 'ts_paint', 01:38:01 INFO - 'tpaint', 01:38:01 INFO - 'sessionrestore', 01:38:01 INFO - 'sessionrestore_no_auto_restore', 01:38:01 INFO - 'tabpaint']}, 01:38:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['tsvgx', 01:38:01 INFO - 'tsvgr_opacity', 01:38:01 INFO - 'tart', 01:38:01 INFO - 'tscrollx', 01:38:01 INFO - 'cart']}, 01:38:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:38:01 INFO - 'tsvgr_opacity', 01:38:01 INFO - 'tart', 01:38:01 INFO - 'tscrollx', 01:38:01 INFO - 'cart']}, 01:38:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:01 INFO - 'talos_options': ['--disable-e10s'], 01:38:01 INFO - 'tests': ['tp5o']}, 01:38:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:01 INFO - 'tests': ['tp5o']}, 01:38:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:01 INFO - 'talos_options': ['--disable-e10s', 01:38:01 INFO - '--xperf_path', 01:38:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:01 INFO - 'tests': ['tp5n']}, 01:38:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:01 INFO - 'talos_options': ['--xperf_path', 01:38:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:01 INFO - 'tests': ['tp5n']}}, 01:38:01 INFO - 'talos.zip': {'path': '', 01:38:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:38:01 INFO - Running post-action listener: _resource_record_post_action 01:38:01 INFO - ##### 01:38:01 INFO - ##### Running create-virtualenv step. 01:38:01 INFO - ##### 01:38:01 INFO - Running pre-action listener: _resource_record_pre_action 01:38:01 INFO - Running main action method: create_virtualenv 01:38:01 INFO - Creating virtualenv /builds/slave/test/build/venv 01:38: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 01:38:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:38:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:38:01 INFO - Using real prefix '/usr' 01:38:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:38:01 INFO - Installing distribute.............................................................................................................................................................................................done. 01:38:03 INFO - Installing pip.................done. 01:38:03 INFO - Return code: 0 01:38:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x7f95fdefbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', '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 01:38: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 01:38: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 01:38:03 INFO - Using env: {'DISPLAY': ':0', 01:38:03 INFO - 'HOME': '/home/cltbld', 01:38:03 INFO - 'LANG': 'en_US.UTF-8', 01:38:03 INFO - 'LANGUAGE': 'en_US:en', 01:38:03 INFO - 'LOGNAME': 'cltbld', 01:38:03 INFO - 'MAIL': '/var/mail/cltbld', 01:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:03 INFO - 'MOZ_NO_REMOTE': '1', 01:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:03 INFO - 'NO_EM_RESTART': '1', 01:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:03 INFO - 'PWD': '/builds/slave/test', 01:38:03 INFO - 'SHELL': '/bin/bash', 01:38:03 INFO - 'SHLVL': '1', 01:38:03 INFO - 'TERM': 'linux', 01:38:03 INFO - 'TMOUT': '86400', 01:38:03 INFO - 'USER': 'cltbld', 01:38:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:03 INFO - '_': '/tools/buildbot/bin/python'} 01:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38: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 01:38:04 INFO - Cleaning up... 01:38:04 INFO - Return code: 0 01:38:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x7f95fdefbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', '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 01:38: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 01:38: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 01:38:04 INFO - Using env: {'DISPLAY': ':0', 01:38:04 INFO - 'HOME': '/home/cltbld', 01:38:04 INFO - 'LANG': 'en_US.UTF-8', 01:38:04 INFO - 'LANGUAGE': 'en_US:en', 01:38:04 INFO - 'LOGNAME': 'cltbld', 01:38:04 INFO - 'MAIL': '/var/mail/cltbld', 01:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:04 INFO - 'MOZ_NO_REMOTE': '1', 01:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:04 INFO - 'NO_EM_RESTART': '1', 01:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:04 INFO - 'PWD': '/builds/slave/test', 01:38:04 INFO - 'SHELL': '/bin/bash', 01:38:04 INFO - 'SHLVL': '1', 01:38:04 INFO - 'TERM': 'linux', 01:38:04 INFO - 'TMOUT': '86400', 01:38:04 INFO - 'USER': 'cltbld', 01:38:04 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:04 INFO - '_': '/tools/buildbot/bin/python'} 01:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:04 INFO - Downloading/unpacking psutil>=0.7.1 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:38:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:06 INFO - Installing collected packages: psutil 01:38:06 INFO - Running setup.py install for psutil 01:38:06 INFO - building 'psutil._psutil_linux' extension 01:38: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 01:38: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 01:38:06 INFO - building 'psutil._psutil_posix' extension 01:38: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 01:38: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 01:38:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:06 INFO - Successfully installed psutil 01:38:06 INFO - Cleaning up... 01:38:06 INFO - Return code: 0 01:38:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x7f95fdefbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', '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 01:38: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 01:38: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 01:38:06 INFO - Using env: {'DISPLAY': ':0', 01:38:06 INFO - 'HOME': '/home/cltbld', 01:38:06 INFO - 'LANG': 'en_US.UTF-8', 01:38:06 INFO - 'LANGUAGE': 'en_US:en', 01:38:06 INFO - 'LOGNAME': 'cltbld', 01:38:06 INFO - 'MAIL': '/var/mail/cltbld', 01:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:06 INFO - 'MOZ_NO_REMOTE': '1', 01:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:06 INFO - 'NO_EM_RESTART': '1', 01:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:06 INFO - 'PWD': '/builds/slave/test', 01:38:06 INFO - 'SHELL': '/bin/bash', 01:38:06 INFO - 'SHLVL': '1', 01:38:06 INFO - 'TERM': 'linux', 01:38:06 INFO - 'TMOUT': '86400', 01:38:06 INFO - 'USER': 'cltbld', 01:38:06 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:06 INFO - '_': '/tools/buildbot/bin/python'} 01:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:38:08 INFO - Installing collected packages: mozsystemmonitor 01:38:08 INFO - Running setup.py install for mozsystemmonitor 01:38:08 INFO - Successfully installed mozsystemmonitor 01:38:08 INFO - Cleaning up... 01:38:09 INFO - Return code: 0 01:38:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x7f95fdefbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', '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 01:38: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 01:38: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 01:38:09 INFO - Using env: {'DISPLAY': ':0', 01:38:09 INFO - 'HOME': '/home/cltbld', 01:38:09 INFO - 'LANG': 'en_US.UTF-8', 01:38:09 INFO - 'LANGUAGE': 'en_US:en', 01:38:09 INFO - 'LOGNAME': 'cltbld', 01:38:09 INFO - 'MAIL': '/var/mail/cltbld', 01:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:09 INFO - 'MOZ_NO_REMOTE': '1', 01:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:09 INFO - 'NO_EM_RESTART': '1', 01:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:09 INFO - 'PWD': '/builds/slave/test', 01:38:09 INFO - 'SHELL': '/bin/bash', 01:38:09 INFO - 'SHLVL': '1', 01:38:09 INFO - 'TERM': 'linux', 01:38:09 INFO - 'TMOUT': '86400', 01:38:09 INFO - 'USER': 'cltbld', 01:38:09 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:09 INFO - '_': '/tools/buildbot/bin/python'} 01:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:09 INFO - Downloading/unpacking blobuploader==1.2.4 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:11 INFO - Downloading blobuploader-1.2.4.tar.gz 01:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:38:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:38:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:11 INFO - Downloading docopt-0.6.1.tar.gz 01:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:38:11 INFO - Installing collected packages: blobuploader, requests, docopt 01:38:11 INFO - Running setup.py install for blobuploader 01:38:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:38:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:38:11 INFO - Running setup.py install for requests 01:38:12 INFO - Running setup.py install for docopt 01:38:12 INFO - Successfully installed blobuploader requests docopt 01:38:12 INFO - Cleaning up... 01:38:12 INFO - Return code: 0 01:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x7f95fdefbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', '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 01:38: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 01:38: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 01:38:12 INFO - Using env: {'DISPLAY': ':0', 01:38:12 INFO - 'HOME': '/home/cltbld', 01:38:12 INFO - 'LANG': 'en_US.UTF-8', 01:38:12 INFO - 'LANGUAGE': 'en_US:en', 01:38:12 INFO - 'LOGNAME': 'cltbld', 01:38:12 INFO - 'MAIL': '/var/mail/cltbld', 01:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:12 INFO - 'MOZ_NO_REMOTE': '1', 01:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:12 INFO - 'NO_EM_RESTART': '1', 01:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:12 INFO - 'PWD': '/builds/slave/test', 01:38:12 INFO - 'SHELL': '/bin/bash', 01:38:12 INFO - 'SHLVL': '1', 01:38:12 INFO - 'TERM': 'linux', 01:38:12 INFO - 'TMOUT': '86400', 01:38:12 INFO - 'USER': 'cltbld', 01:38:12 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:12 INFO - '_': '/tools/buildbot/bin/python'} 01:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:12 INFO - Running setup.py (path:/tmp/pip-BXtXDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:12 INFO - Running setup.py (path:/tmp/pip-26iele-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:12 INFO - Running setup.py (path:/tmp/pip-Za1zZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:12 INFO - Running setup.py (path:/tmp/pip-KM7EFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:12 INFO - Running setup.py (path:/tmp/pip-rDm60o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:13 INFO - Running setup.py (path:/tmp/pip-oeD4N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:13 INFO - Running setup.py (path:/tmp/pip-4zfOk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:13 INFO - Running setup.py (path:/tmp/pip-ecFInD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:13 INFO - Running setup.py (path:/tmp/pip-fb13wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:13 INFO - Running setup.py (path:/tmp/pip-B5sg0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:13 INFO - Running setup.py (path:/tmp/pip-lUoqJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:13 INFO - Running setup.py (path:/tmp/pip-OFSBj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:13 INFO - Running setup.py (path:/tmp/pip-gnBhqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:13 INFO - Running setup.py (path:/tmp/pip-rTnZGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:13 INFO - Running setup.py (path:/tmp/pip-Ed0sHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:13 INFO - Running setup.py (path:/tmp/pip-MXFIuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:13 INFO - Running setup.py (path:/tmp/pip-78jNe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:38:13 INFO - Running setup.py install for manifestparser 01:38:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Running setup.py install for mozcrash 01:38:14 INFO - Running setup.py install for mozdebug 01:38:14 INFO - Running setup.py install for mozdevice 01:38:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Running setup.py install for mozfile 01:38:14 INFO - Running setup.py install for mozhttpd 01:38:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Running setup.py install for mozinfo 01:38:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Running setup.py install for mozInstall 01:38:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Running setup.py install for mozleak 01:38:14 INFO - Running setup.py install for mozlog 01:38:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:38:14 INFO - Running setup.py install for moznetwork 01:38:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:38:15 INFO - Running setup.py install for mozprocess 01:38:15 INFO - Running setup.py install for mozprofile 01:38:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:38:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:38:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:38:15 INFO - Running setup.py install for mozrunner 01:38:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:38:15 INFO - Running setup.py install for mozscreenshot 01:38:15 INFO - Running setup.py install for moztest 01:38:15 INFO - Running setup.py install for mozversion 01:38:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:38:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:38:15 INFO - Cleaning up... 01:38:15 INFO - Return code: 0 01:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x7f95fdefbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', '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 01:38: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 01:38: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 01:38:15 INFO - Using env: {'DISPLAY': ':0', 01:38:15 INFO - 'HOME': '/home/cltbld', 01:38:15 INFO - 'LANG': 'en_US.UTF-8', 01:38:15 INFO - 'LANGUAGE': 'en_US:en', 01:38:15 INFO - 'LOGNAME': 'cltbld', 01:38:15 INFO - 'MAIL': '/var/mail/cltbld', 01:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:15 INFO - 'MOZ_NO_REMOTE': '1', 01:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:15 INFO - 'NO_EM_RESTART': '1', 01:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:15 INFO - 'PWD': '/builds/slave/test', 01:38:15 INFO - 'SHELL': '/bin/bash', 01:38:15 INFO - 'SHLVL': '1', 01:38:15 INFO - 'TERM': 'linux', 01:38:15 INFO - 'TMOUT': '86400', 01:38:15 INFO - 'USER': 'cltbld', 01:38:15 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:15 INFO - '_': '/tools/buildbot/bin/python'} 01:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:15 INFO - Running setup.py (path:/tmp/pip-NPNAMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:16 INFO - Running setup.py (path:/tmp/pip-EJ6OMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:16 INFO - Running setup.py (path:/tmp/pip-KT9vIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:16 INFO - Running setup.py (path:/tmp/pip-MCouU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:16 INFO - Running setup.py (path:/tmp/pip-_00dEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:16 INFO - Running setup.py (path:/tmp/pip-cpmRab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:16 INFO - Running setup.py (path:/tmp/pip-nqYiR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:16 INFO - Running setup.py (path:/tmp/pip-OBYBSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:16 INFO - Running setup.py (path:/tmp/pip-qoxTkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:16 INFO - Running setup.py (path:/tmp/pip-WTiGCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:16 INFO - Running setup.py (path:/tmp/pip-qSX0Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:16 INFO - Running setup.py (path:/tmp/pip-jyP2ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38: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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:16 INFO - Running setup.py (path:/tmp/pip-J1wRix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38:16 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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:16 INFO - Running setup.py (path:/tmp/pip-C1TJUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:16 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)) 01:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:16 INFO - Running setup.py (path:/tmp/pip-CbjnRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38: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)) 01:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:17 INFO - Running setup.py (path:/tmp/pip-KjjlbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38: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)) 01:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:17 INFO - Running setup.py (path:/tmp/pip-xgSLeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:18 INFO - Downloading blessings-1.6.tar.gz 01:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:38:19 INFO - Installing collected packages: blessings 01:38:19 INFO - Running setup.py install for blessings 01:38:19 INFO - Successfully installed blessings 01:38:19 INFO - Cleaning up... 01:38:19 INFO - Return code: 0 01:38:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:19 INFO - Reading from file tmpfile_stdout 01:38:19 INFO - Current package versions: 01:38:19 INFO - argparse == 1.2.1 01:38:19 INFO - blessings == 1.6 01:38:19 INFO - blobuploader == 1.2.4 01:38:19 INFO - docopt == 0.6.1 01:38:19 INFO - manifestparser == 1.1 01:38:19 INFO - mozInstall == 1.12 01:38:19 INFO - mozcrash == 0.17 01:38:19 INFO - mozdebug == 0.1 01:38:19 INFO - mozdevice == 0.48 01:38:19 INFO - mozfile == 1.2 01:38:19 INFO - mozhttpd == 0.7 01:38:19 INFO - mozinfo == 0.9 01:38:19 INFO - mozleak == 0.1 01:38:19 INFO - mozlog == 3.1 01:38:19 INFO - moznetwork == 0.27 01:38:19 INFO - mozprocess == 0.22 01:38:19 INFO - mozprofile == 0.28 01:38:19 INFO - mozrunner == 6.11 01:38:19 INFO - mozscreenshot == 0.1 01:38:19 INFO - mozsystemmonitor == 0.0 01:38:19 INFO - moztest == 0.7 01:38:19 INFO - mozversion == 1.4 01:38:19 INFO - psutil == 3.1.1 01:38:19 INFO - requests == 1.2.3 01:38:19 INFO - wsgiref == 0.1.2 01:38:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x7f95fdefbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', '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 01:38: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 01:38: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 01:38:19 INFO - Using env: {'DISPLAY': ':0', 01:38:19 INFO - 'HOME': '/home/cltbld', 01:38:19 INFO - 'LANG': 'en_US.UTF-8', 01:38:19 INFO - 'LANGUAGE': 'en_US:en', 01:38:19 INFO - 'LOGNAME': 'cltbld', 01:38:19 INFO - 'MAIL': '/var/mail/cltbld', 01:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:19 INFO - 'MOZ_NO_REMOTE': '1', 01:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:19 INFO - 'NO_EM_RESTART': '1', 01:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:19 INFO - 'PWD': '/builds/slave/test', 01:38:19 INFO - 'SHELL': '/bin/bash', 01:38:19 INFO - 'SHLVL': '1', 01:38:19 INFO - 'TERM': 'linux', 01:38:19 INFO - 'TMOUT': '86400', 01:38:19 INFO - 'USER': 'cltbld', 01:38:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:19 INFO - '_': '/tools/buildbot/bin/python'} 01:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38: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)) 01:38:19 INFO - Cleaning up... 01:38:19 INFO - Return code: 0 01:38:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x7f95fdefbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', '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 01:38: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 01:38: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 01:38:19 INFO - Using env: {'DISPLAY': ':0', 01:38:19 INFO - 'HOME': '/home/cltbld', 01:38:19 INFO - 'LANG': 'en_US.UTF-8', 01:38:19 INFO - 'LANGUAGE': 'en_US:en', 01:38:19 INFO - 'LOGNAME': 'cltbld', 01:38:19 INFO - 'MAIL': '/var/mail/cltbld', 01:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:19 INFO - 'MOZ_NO_REMOTE': '1', 01:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:19 INFO - 'NO_EM_RESTART': '1', 01:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:19 INFO - 'PWD': '/builds/slave/test', 01:38:19 INFO - 'SHELL': '/bin/bash', 01:38:19 INFO - 'SHLVL': '1', 01:38:19 INFO - 'TERM': 'linux', 01:38:19 INFO - 'TMOUT': '86400', 01:38:19 INFO - 'USER': 'cltbld', 01:38:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:19 INFO - '_': '/tools/buildbot/bin/python'} 01:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:19 INFO - Downloading/unpacking jsonschema 01:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:38:21 INFO - Downloading/unpacking functools32 (from jsonschema) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:21 INFO - Downloading functools32-3.2.3-2.tar.gz 01:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:38:22 INFO - warning: no files found matching '*.txt' 01:38:22 INFO - no previously-included directories found matching 'build' 01:38:22 INFO - no previously-included directories found matching 'dist' 01:38:22 INFO - no previously-included directories found matching '.git*' 01:38:22 INFO - Installing collected packages: jsonschema, functools32 01:38:22 INFO - Running setup.py install for functools32 01:38:22 INFO - warning: no files found matching '*.txt' 01:38:22 INFO - no previously-included directories found matching 'build' 01:38:22 INFO - no previously-included directories found matching 'dist' 01:38:22 INFO - no previously-included directories found matching '.git*' 01:38:22 INFO - Successfully installed jsonschema functools32 01:38:22 INFO - Cleaning up... 01:38:22 INFO - Return code: 0 01:38:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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 0x7f95fdefbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', '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 01:38: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 01:38: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 01:38:22 INFO - Using env: {'DISPLAY': ':0', 01:38:22 INFO - 'HOME': '/home/cltbld', 01:38:22 INFO - 'LANG': 'en_US.UTF-8', 01:38:22 INFO - 'LANGUAGE': 'en_US:en', 01:38:22 INFO - 'LOGNAME': 'cltbld', 01:38:22 INFO - 'MAIL': '/var/mail/cltbld', 01:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:22 INFO - 'MOZ_NO_REMOTE': '1', 01:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:22 INFO - 'NO_EM_RESTART': '1', 01:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:22 INFO - 'PWD': '/builds/slave/test', 01:38:22 INFO - 'SHELL': '/bin/bash', 01:38:22 INFO - 'SHLVL': '1', 01:38:22 INFO - 'TERM': 'linux', 01:38:22 INFO - 'TMOUT': '86400', 01:38:22 INFO - 'USER': 'cltbld', 01:38:22 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:22 INFO - '_': '/tools/buildbot/bin/python'} 01:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:22 INFO - Downloading/unpacking flake8 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:38:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:38:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38: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 01:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:25 INFO - no previously-included directories found matching 'docs/_build' 01:38:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:38:25 INFO - Running setup.py install for pep8 01:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:25 INFO - no previously-included directories found matching 'docs/_build' 01:38:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:38:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:38:25 INFO - Cleaning up... 01:38:25 INFO - Return code: 0 01:38:25 INFO - Running post-action listener: _resource_record_post_action 01:38:25 INFO - Running post-action listener: _start_resource_monitoring 01:38:25 INFO - Starting resource monitoring. 01:38:25 INFO - ##### 01:38:25 INFO - ##### Running install step. 01:38:25 INFO - ##### 01:38:25 INFO - Running pre-action listener: _resource_record_pre_action 01:38:25 INFO - Running main action method: install 01:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:25 INFO - Reading from file tmpfile_stdout 01:38:25 INFO - Detecting whether we're running mozinstall >=1.0... 01:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:38:25 INFO - Reading from file tmpfile_stdout 01:38:25 INFO - Output received: 01:38:25 INFO - Usage: mozinstall [options] installer 01:38:25 INFO - Options: 01:38:25 INFO - -h, --help show this help message and exit 01:38:25 INFO - -d DEST, --destination=DEST 01:38:25 INFO - Directory to install application into. [default: 01:38:25 INFO - "/builds/slave/test"] 01:38:25 INFO - --app=APP Application being installed. [default: firefox] 01:38:25 INFO - mkdir: /builds/slave/test/build/application 01:38: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'] 01:38: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 01:38:41 INFO - Reading from file tmpfile_stdout 01:38:41 INFO - Output received: 01:38:41 INFO - /builds/slave/test/build/application/firefox/firefox 01:38:41 INFO - Running post-action listener: _resource_record_post_action 01:38:41 INFO - ##### 01:38:41 INFO - ##### Running run-tests step. 01:38:41 INFO - ##### 01:38:41 INFO - Running pre-action listener: _resource_record_pre_action 01:38:41 INFO - Running main action method: run_tests 01:38:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:41 INFO - Python 2.7.3 01:38:41 INFO - Return code: 0 01:38:41 INFO - grabbing minidump binary from tooltool 01:38: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')]} 01:38: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 0x1c91410>, '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 0x1c92310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c927a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38: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 01:38: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 01:38:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:41 INFO - Return code: 0 01:38:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:38:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:38:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:38:42 INFO - Return code: 0 01:38: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/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 01:38: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/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 01:38:42 INFO - Using env: {'DISPLAY': ':0', 01:38:42 INFO - 'HOME': '/home/cltbld', 01:38:42 INFO - 'LANG': 'en_US.UTF-8', 01:38:42 INFO - 'LANGUAGE': 'en_US:en', 01:38:42 INFO - 'LOGNAME': 'cltbld', 01:38:42 INFO - 'MAIL': '/var/mail/cltbld', 01:38:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:42 INFO - 'MOZ_NO_REMOTE': '1', 01:38:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:42 INFO - 'NO_EM_RESTART': '1', 01:38:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:42 INFO - 'PWD': '/builds/slave/test', 01:38:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:42 INFO - 'SHELL': '/bin/bash', 01:38:42 INFO - 'SHLVL': '1', 01:38:42 INFO - 'TERM': 'linux', 01:38:42 INFO - 'TMOUT': '86400', 01:38:42 INFO - 'USER': 'cltbld', 01:38:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091', 01:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:42 INFO - '_': '/tools/buildbot/bin/python'} 01:38: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/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 01:38:42 INFO - mozversion application_buildid: 20160501005842 01:38:42 INFO - mozversion application_changeset: 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 01:38:42 INFO - mozversion application_display_name: Nightly 01:38:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:42 INFO - mozversion application_name: Firefox 01:38:42 INFO - mozversion application_remotingname: firefox 01:38:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:38:42 INFO - mozversion application_vendor: Mozilla 01:38:42 INFO - mozversion application_version: 49.0a1 01:38:42 INFO - mozversion platform_buildid: 20160501005842 01:38:42 INFO - mozversion platform_changeset: 7e4ac3f24fa87986c044d9ee13c1cf557ea55d07 01:38:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:38:42 INFO - mozversion platform_version: 49.0a1 01:38:42 INFO - using testdate: 1462091922 01:38:42 INFO - actual date: 1462091922 01:38:42 INFO - starting webserver on 'localhost:58405' 01:38:42 INFO - SUITE-START | Running 2 tests 01:38:42 INFO - TEST-START | dromaeo_css 01:38:42 INFO - operating with platform_type : linux_ 01:38:42 INFO - Initialising browser for dromaeo_css test... 01:38:42 INFO - TEST-INFO | started process 14296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOJQ18i/profile http://localhost:58405/getInfo.html) 01:38:46 INFO - PROCESS | 14296 | __metrics Screen width/height:1600/1200 01:38:46 INFO - PROCESS | 14296 | colorDepth:24 01:38:46 INFO - PROCESS | 14296 | Browser inner width/height: 1024/697 01:38:46 INFO - PROCESS | 14296 | __metrics 01:38:47 ERROR - PROCESS | 14296 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:38:48 INFO - TEST-INFO | 14296: exit 0 01:38:48 INFO - Browser initialized. 01:38:48 INFO - Running cycle 1/1 for dromaeo_css test... 01:38:48 INFO - TEST-INFO | started process 14377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOJQ18i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:00 INFO - PROCESS | 14377 | RSS: Main: 156110848 01:39:00 INFO - PROCESS | 14377 | 01:39:52 INFO - PROCESS | 14377 | 1462091992248 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] 01:42:03 INFO - PROCESS | 14377 | Cycle 1(1): loaded http://localhost:58405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58405/tests/dromaeo/cssquery-ext.html) 01:42:04 INFO - PROCESS | 14377 | RSS: Main: 264404992 01:42:04 INFO - PROCESS | 14377 | 01:45:06 INFO - PROCESS | 14377 | Cycle 1(1): loaded http://localhost:58405/tests/dromaeo/cssquery-ext.html (next: http://localhost:58405/tests/dromaeo/cssquery-jquery.html) 01:45:07 INFO - PROCESS | 14377 | RSS: Main: 239452160 01:45:07 INFO - PROCESS | 14377 | 01:48:09 INFO - PROCESS | 14377 | Cycle 1(1): loaded http://localhost:58405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58405/tests/dromaeo/cssquery-mootools.html) 01:48:10 INFO - PROCESS | 14377 | RSS: Main: 241463296 01:48:10 INFO - PROCESS | 14377 | 01:51:12 INFO - PROCESS | 14377 | Cycle 1(1): loaded http://localhost:58405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58405/tests/dromaeo/cssquery-prototype.html) 01:51:13 INFO - PROCESS | 14377 | RSS: Main: 233459712 01:51:13 INFO - PROCESS | 14377 | 01:54:15 INFO - PROCESS | 14377 | Cycle 1(1): loaded http://localhost:58405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58405/tests/dromaeo/cssquery-yui.html) 01:54:16 INFO - PROCESS | 14377 | RSS: Main: 204902400 01:54:16 INFO - PROCESS | 14377 | 01:57:19 INFO - PROCESS | 14377 | Cycle 1(1): loaded http://localhost:58405/tests/dromaeo/cssquery-yui.html (next: http://localhost:58405/tests/dromaeo/cssquery-dojo.html) 01:57:19 INFO - PROCESS | 14377 | RSS: Main: 280555520 01:57:19 INFO - PROCESS | 14377 | 01:57:19 INFO - PROCESS | 14377 | __start_tp_report 01:57:19 INFO - PROCESS | 14377 | _x_x_mozilla_page_load 01:57:19 INFO - PROCESS | 14377 | _x_x_mozilla_page_load_details 01:57:19 INFO - PROCESS | 14377 | |i|pagename|runs| 01:57:19 INFO - PROCESS | 14377 | |0;dojo.html;2561.1804222648752;2604.257786530839;2635.644188034616;2639.564471862143;2647.02060237712;4511.887202819931;4638.97680511597;4643.210654188788;4643.396358473398;4710.364100846389;4580.702254353465;4639.141758774629;4675.088357770236;4677.953220467794;4678.5789278964885;4251.0860165064505;4269.487661480626;4293.957060429402;4339.804708788096;4380.8685739427865;4301.161273551658;4352.564743525654;4382.298832186851;4395.1649186654595;4399;4163.708540402173;4255;4275.358696195564;4291.485021797404;4298.269294219975;4224.197402493547;4245.150969806051;4248.490181178247;4252.957470425287;4256.893577660552;4223.535411104776;4225.408442818008;4226.492820861486;4228.429162063113;4230.915381692349;4534.7052441591195;4553.886152846172;4588.655850811202;4632.72203667781;4654.930176047362;4960.23116416956;4980.576650984671;4981.501849815026;4983.526564976321;5031.295618613397;4827.155247831651;4988.800447982077;4995.925061124086;5002.52476014778;5013.6490445668815;4639.373684552576;4659.976700116477;4665.743384113838;4702.200625893538;4719.622430205575;5056;5057.317262169634;5059.822906198266;5063.5695965843315;5128.25640282157;4791.401074865642;4828.106800241966;4863.124637565202;4886.633502487328;4925.088858561177;4896.779644915988;4912.287718280901;4917.188663870493;4958.851234462972;4966.056449274699;4852.51474852519;4875.780589873464;4876.097921884463;4882.847612008894;4920.950790492049;4817.2774083887;4867.221244600847;4927.679700819435;4961.156603377434;5045.84862454127;4242.915141697149;4264.360345948133;4286.592773686495;4299.656027517791;4300.440942677432;3700.3154416433044;3708.7589306694977;3714.665680088805;3737.0844143185095;3746.4942232798767;4234.724742891703;4312.180685669713;4318.050028993616;4329.112531930947;4347.891302717394;4908.779104940286;4929.359183306147;4990.500949905053;5068.82259120929;5077.365329333833;4279.550647182064;4282.914341713148;4305.268104422193;4318.093200427883;4318.589733975267;4494.258447356215;4496.977515112403;4504.459464864171;4511.075229577994;4547;4542.3413605027745;4654.092451971833;4709.905801883943;4735.502772208868;4735.952640473689;4992.525710057539;5001.474845141353;5002.52476014778;5003.77483013258;5056.064628043824;4684.48470668233;4690.554397332248;4691.929621055755;4696.342512048384;4736.313234581035;4743.667943244078;4867.1969125093965;4878.512148785093;4943.184374578154;4947.777350019186;4928.310036594808;4940.184869496493;4951.653384263067;4975.353204083446;4997.725125118153;4733.881652958704;4822.8794280143275;4827.734474603931;4830.492798256273;4881.829135980223;4794.880127996828;4845.709257444564;4852.73309967941;4885.438174609965;4899.363082799213;4742.07529531738;4766.95233047679;4783.425988881357;4792.137415265286;4832.613390928647;4746.525347465225;4825.541573550507;4864.829730959399;4892.437369702529;4936.851894443173;4758.666893317434;4788.569028787426;4796.784144713426;4797.760111994457;4837.467878533429 01:57:19 INFO - PROCESS | 14377 | |1;ext.html;564.9887002259952;590.8995470769969;590.9615874968127;605.7062324772485;612.2438788096703;34723;36085.63914360859;36092.819535902316;36179.4573081404;36215.818920905425;36379.63620363796;36886.262274754554;36954.44568331477;37052.44421333682;37054.444183337204;7437.5165614235175;7628.199039100898;7629.885551716701;7632.389408847279;7636.427267954898;7440.888386674177;7557.05536807899;7560.924390756105;7568.508046976929;7719.884201736979;7672;7754.185810489874;7754.495957762756;7757.301842834144;7761.3402860756905;7680.769576912701;7749.070111586618;7751.186125456802;7752.418568607321;7752.961235193844;7597.278258565483;7730.420218483636;7731.072271327421;7734.303912647889;7736.34241089508;35258.29483410317;35700.64299356999;35714.642853571655;35856.28287434263;35887.82056089729;3111.9066428007195;3387.661233876617;3526.7354948378975;3655.689266412358;3865.4974853269177;25744.098956536618;26022.089226877157;26056.95772169111;26125.477490450274;26603.46793064128;3403.3533628610485;3440.7247420206572;3449.482577613353;3471.8090505022215;3673.669369756735;242686;246030;246858;247346.7632661843;247370;30908.22729431782;31710.207244819063;31752;31759.682403175673;51090.23364649533;32383.838080809917;32395.67604323974;32421.351572968408;32509.837450812596;32522.186945326084;13334.466621335037;13422.127561708458;13537.729245415037;13539.11995720275;13540.59378218655;11173.888261117447;11224.158188135922;11256.549738010552;11259.099272058216;11407.942960285145;8123.6750529978135;8170.305524030405;8196.67213311461;8253.628586713492;8264.256216940505;3151.936961260762;3159.4786860167815;3173.444647186733;3178.952315715266;3195.5366471861917;884.4516399832016;1004.9497525123861;1011.9494025298706;1018.332991890313;1020.2348238820884;28607;28742.425151496853;28967.730326295383;29368.853155734512;29403.852980735388;968.5205823117602;976.4434272464769;1046.8325067989085;1081.7836432713489;1111.8721347045032;15006.849931500763;15376.615584610474;15512.301946412439;15656.530304090895;15764.921175394278;360353;363442;367623;367880;368134;49620;50379.49620503822;50409;50595.241071383956;50622.74688626533;1146.7821113988316;1157.4733496259182;1188.0851744157123;1221.0841868598372;1271.281725824906;25249.621255681548;26046;26078.73921260763;26555.33611659724;27552.86223568869;35455.82272088623;35565.466518002766;35813.1046723834;35828.462573061945;35848.103797405274;220686;221852;222369;222695;223140;20939.476513087295;23453.41366465852;24308.87845560761;25999.350016249744;26447.60328595111;36145.63854361423;37116.443253350684;37233.6276637241;37409.25181496409;37692.81153594214;31526.842365788943;31752;32439;32594.51108233331;33234.83382583072;34133.48799768055;35027.649723503455;35426.468602971494;35620.643793561736;36134;35019;35134;35832.820835895654;35833.64166358407;35848.8207558971;31267.37465250728;31867.6813231874;32036.19909502281;32121;32308.676913231506;24446.26661200167;24727;24801.525879028526;24835.627465588394;24928 01:57:19 INFO - PROCESS | 14377 | |2;jquery.html;376.4353469795307;380.1048530710177;384.3600405325132;386.17744204843694;387.6549870615155;15851.603709907244;16173.838261617395;17223.397181098662;17237.741433878502;17245;11185.44072796361;16090;16825.663486730256;16834.24245908934;16836.410725624606;3471.7743346682387;4493.101379724052;4650.813967441299;4651.1162879053045;4658.1848176568965;3620.913725882238;5122.231665250205;5394.838154855341;5394.946050539484;5397.811076612319;5313.760880760356;5374.059539580578;5375.704336261504;5376.274202982587;5395.460453954613;5194.740262986855;5306;5334.359876814807;5335.0663633864115;5338.91991620126;5105.387353517602;5121.4622464641425;5129.435762066169;5144.459831717691;5156.484351564851;12081.697957551043;12204.145709800228;12233.93883030588;12294.938525307405;12341;1794.6590147871993;1803.1615298886081;1828.9908550457296;1901.8003109673423;1904.552430178907;9236.307276954256;9316.161545460942;9670.806583868354;9892.406455612687;13176.209427434289;1762.9206685699173;1833.8166183381688;1846.2707230643955;1867.411765293928;1894.3748562974185;67589.3241067588;69690.65154674245;71243.28756712418;71993.9208510809;72347.63826180836;9993.250506211918;10125.59497620087;10170.152357339957;10182.643607473703;10290.073893349634;13901.58295251144;13982.300884955712;13993.160410375207;13997.790033149511;14002.929985350009;7358.00666909971;7449.255074492507;7453;7523.570144152972;7532.246775322534;7136.393406560397;7188.353048225685;7281.490295679251;7289.5261807982315;7296.343329100407;4271.9786401067795;4314.71954322968;4388.166248412791;4395.7582332972;4466;1668.7163182259046;1741.0304505726963;1762.2950819672233;1823.8996855172827;1826.452064380707;780.1457404142454;853.6628031927354;894.9239314658197;911.1799380557419;916.7112359606703;16218;16233.918830406008;16463.34146634145;16855.915720421566;17153;849.4860609331389;887.6937456577471;912.6075787411344;921.5714692667941;943.0239701908491;9022.548872556346;9481.762955926019;9547.570359333846;9600.471974041495;9672.661456848977;398179;402826;415772;420261;421725;77344.61327693438;79611.60194198992;79676.60161699154;79739.60130199311;79766.20233797588;920.5075284722775;939;950.6862735297335;952.0194199974038;954.7994921066654;14802.851971480148;14925.850741492446;14996.550103496913;15004.174770387734;15340.232988350761;32476.675233247366;33620;34431.827840860635;34816;35277.29445411129;47331;48786;49173;49414.25878611895;49499.50500494949;7467.551946883204;7534.54792712439;7599;7609.315161635479;7671.424643151898;6740;8271.379646526655;9868.259880508847;10516.15870730355;10770.515326810155;8781;8856.202941735275;8901.688440904538;8992.370534062553;9420.528973551433;9629.470379129216;9668.129868311886;9740.198063358019;9789.804203916025;9808.9019109808;8924.509151996703;9153.405028673114;9189.172974432333;9231.723048308562;9495.477748723886;7475.289847464483;7509;7523.435742319458;7582.317591416799;7631.855221716565;8153.918460815553;9058.094190580889;9138.543072846463;9185.173334399937;9321.580528876353 01:57:19 INFO - PROCESS | 14377 | |3;mootools.html;1231.9199252048622;1421.0549984260467;1485.2425263115808;1613.3949768836687;1776.360510216321;7278.0174676418665;7645.120811106724;7663.080430348352;7669.50148240364;7670.92329076709;7449.441291903116;7608;7613.467057305991;7624.237576242373;7634.274743899335;1932.8357089647398;1988.7712913015043;1989.512569420494;2177.3032629558547;2204.151401710337;2193.1885202475105;2256.717910261217;2261.457250259942;2262.739784924738;2263.106073101124;2165.036558731365;2184.541246338263;2194.7476040255337;2196.2752291743686;2214.26929113393;1884.8586356023216;2128.3082998025548;2192.166976548909;2196.9121235150574;2197.8021978021893;2218.7337519497764;2248.640217565198;2249.718785151856;2252.40311317501;2253.3352660965056;7504;7534.886976695354;7546.660400281946;7547.811304717371;7554.622268886534;4471.8658440246845;4652.418447694038;4666.673332866701;4677.6257899367965;4678.7426691531955;2755.2285360099204;2800.173948685143;2900.912972610825;2917.124862541229;2925.736683698456;889.7820034091624;945.0171821305834;946.857971304303;1761.1018380625974;1783.9108044597717;9719.125278724949;9814.607415703364;9820.263480239011;9840;9854.113129818279;3916.060145565101;4024.4566983457444;4073.348264277701;4098.7950602469755;4102.384642303678;7946.523208607502;8008.119106898236;8019.518828870287;8020;8022.719204827803;4470.798814053375;4557.977210113928;4558.430196225472;4579.679422440464;4586.289125185602;3798.3542797724454;4219.3249080147025;4231.217224813419;4290.570942905684;4338.60952514269;3472;3557.573091229069;3588.246468241646;3589.3000864831106;3590.2460483298278;1053.5259133390005;1059.1156384418941;1065.5471424644495;1072.1690689715533;1077.7197928538637;866.6230189867301;866.7616405488541;882.34706317326;908.4685459006555;911.9452832830051;5335.306410166731;5368.2752828367675;5415.891682166334;5556.888862222814;5605;379.7322887364401;402.3287501548371;410.8089738271718;410.8890599538108;412.13451751321986;3576.910577235538;3724;3748.2878253131817;3785.73499855013;3788.318102741478;9239.676611318706;9541.618335266512;9712.611495540099;9740.074692904163;9763.316567840184;9616.51917404127;9696.75758106053;9705.980872008478;9726.221902247804;9735.269854760922;7196.352328290479;7235.167955685059;7352.19125896151;7392.039034925425;7478.252174782587;5350.411454739898;5412.350517937873;5419.376771671308;5458.4541545845095;5543.501084902378;8844.292456603585;8877.822443551222;8965.98265390282;9032.45805251687;9043.366964312436;8504.362172836938;8651.264642505206;8718.215360617574;8725.083866194213;8971.16091201289;5767.68277744728;6443.097966284818;6671.566348187546;6678.565893216925;6803.829904252433;7437.51656142349;7478.027856378636;7534.886976695244;7536.7362142324755;7550.35821955118;6439.259485159267;6810.148731408574;6851.246362899978;6945.236024037453;6947.756828510978;6718.798436046926;6729;6797.354251346114;6859.588424694534;6909.585424874524;6424.518161138027;6440.001799721051;6498.187726534184;6563.212414510289;6578.177727784027;4725.881852953704;4823.95176048235;4920.704757714549;4944.28307895346;4967.801287948441;4824.49342818999;4828;4916.9754151230445;4969.35398398206;4993.126202914548 01:57:19 INFO - PROCESS | 14377 | |4;prototype.html;301.5100461749657;304.7546724886467;304.9405365953639;307.60472792461684;310.89274200400854;4622.745748983804;4657.930131048032;4683.016566521031;4698.953010469894;4726.834560790373;4628.472604040667;4636.2581986882105;4637.072585482909;4654.138984287909;4669.486356500782;3508.9298214035766;3619.7285203609704;3626.6373362663653;3627.52842130524;3658.5609726832818;3561.269939662376;3652.9223878955772;3714.4428335749585;3714.7771133732062;3739.3456145174623;3644.125409901631;3695.8336874840697;3707.518022657064;3712.257548490299;3733.701303895682;3594.658507441789;3661.743677942545;3684.5446048810704;3694.07648087978;3704.944425833615;3299.5215693724276;3301.4387554115856;3307.6361600223954;3309.3712194682935;3317.4194515959853;4418.917365245503;4428.070105277896;4442.911141777146;4443.577860103285;4458.328126952393;4181.310083836163;4188.68584856137;4191.7275377100395;4200.810963506619;4209.137126889011;4685.976570117162;4776.80892764289;4810.7113573185725;4827.903441931142;4834.202356611155;3595.388783906742;3600.873969411058;3609.963900360989;3611.2777444511203;3617.3488772021024;5083.161278389061;5090.2110172922885;5093.923591146136;5100.5919526438165;5106.4893510648635;3378.915527111793;3671.9082022949106;3675.852965881335;3676.9080772980888;3690.4648825920626;3629.1108678373967;3632.6387847899077;3638.7452878298263;3651.926961460756;3655.524781778352;4112.527059388149;4116.732412393185;4117.300058989979;4128.91742165155;4132.173565286895;4834.540718631724;4863.586595139382;4880.292357608198;4898.24077268024;4921.335619691367;1300.2458574027041;1317.3676635214958;1334.753070681927;1339.1228745171927;1341.4097796969302;884.3411658314596;888.4891187567175;901.4726385064679;910.0717268386209;913.6254135804288;4179.895502612399;4264.253755592821;4390.978045109754;4403.295472724413;4426.712263702849;5006.199008158677;5027.271045698353;5060.696358218519;5081.466446023114;5092.210707340369;4357.869263922087;4388.780560971939;4390.648748100144;4390.912181756347;4395.8021889014435;2751.761707231714;2859.9285017874718;2870.598116263725;2875.396166804994;2877.812942158753;5053.823116190915;5091.414487334004;5094.159463688524;5134.409542902539;5135.281060651511;5324.733763311819;5562.833115006556;5563.248961390242;5563.471470210324;5590.077637189818;5060.949390506048;5082.822101226439;5092.6435149539175;5115.232715092691;5127.64106512548;5371.62398632092;5375.747672658142;5385;5426.755795989269;5433.619646624698;4758.286257061469;5039.143345631178;5309.58413921657;5323.866903327448;5347.812826551052;4815.95184048155;4833.41998960113;4836.637252206169;4836.863337115846;4842.83050093245;3562.1806984393215;3583.4445660922597;3595.3887839066897;3597.2805438912847;3603.117236277129;4808.35087263229;5082.695038297714;5097.108006098843;5104.234364845154;5112.897742045213;4873.634477414137;4942.975285123552;4952.356193694796;4953.529414705597;5005;4911.091448082117;4931.901361972812;4937.432195297587;4946.307516947702;4956.6530342877095;4610.400647915883;4776.498467660985;4840.6127509798425;4843.2250839865455;4861.878453038702;4654.348391225299;4772.141014617402;4944.554990050912;4957.182064959241;4964.081644895706;4881.633877459134;4896.583790377857;4911.8280860169725;4913.336699545515;4913.452262537432 01:57:19 INFO - PROCESS | 14377 | |5;yui.html;630.5680608782983;641.8812519683859;759.096674956801;773.566802590549;781.2695130053404;11340.262882912615;11514.654560363191;11564.479598418071;11598.246114002604;12057.577984770534;11995.940020299908;12063.577774777885;12077.516899324039;12091.516339346415;12150.02799776018;623.688155922039;760.7147319755092;761.1589193940699;765.9885101723479;769.0387016229713;769.734441617641;770.0066913681372;770.118214644232;773.3001633521644;777.6733771815851;816.2245866426889;816.2653611749444;816.2898278497715;818.705266104202;819.5328662662284;663.0352836622702;811.8011087283653;814.0028465130198;827.1108558299821;841.8063845315551;603.387561624951;609.9725512351911;617.7745123030062;619.2321521313584;619.6065498408498;12333.62999110028;12425.75148497025;12442.315672638002;12445.751084978341;12467.563635272722;11915.165938384316;12340.444679989421;12542.435590398454;12781.297028663419;12806.48774049037;9888.703338899773;9903.653372132012;9949.403035817802;10056.849147262797;10098.242631802645;3287.96712032879;3307.8676852925855;3326;3355.362481128602;3408.3353746019534;41521.37717934234;41611.1677766446;41739.7913010436;41939.1612167758;42001.78999105016;9614.278929080347;9756.95121524402;10057;10066.09405153525;10095.24285678577;15868.20658967047;15931.601709957113;15946.840531594535;16023.278952447168;16026.519204423887;6198.163247961557;6276.623402595859;6356.014817703263;6435;6540.247871494839;3598.982005089958;3606.1165014571075;3624.9456258156147;3715.8142092895246;3717.925641487155;2840.5171120909495;2894.1028281232884;2905.5060639691305;2910.63617047869;2912.796104272723;476.7592365855221;498.7755510020505;505.36324231468615;508.32646743065584;510.8314256295488;536.948989845964;565.03346507517;579.5537436174122;582.5194214772829;589.6874656432097;7408.629568521553;7410.555366678017;7489.775306740807;7666.923330766621;7675.923240767521;457.86721850662934;505.3329604921468;567.6508946997567;584.899498233421;593.2317648645015;3427.8971630851115;3511.964880351215;3575.66031227033;3583.6416358363954;3589.569251689814;50611.74694126506;51101.488985110416;52255.73872130615;52459;52640.47359526356;45166.77416612962;46823;46885.53114468812;47134.71883125897;47433.28850067252;42437.1512569753;42902;42984;43316.78341608335;43538.34692479552;7429.294217049372;7560.281773231534;7584.355329796808;7739.41954353437;7739.729109481141;28787.712122878504;28902.132936011953;29245.561316580694;29851.701482984892;29915.102546923627;37498.62501375061;37889.24221515499;38115.80942095272;39094.609053909095;39103.2179356417;9190.264778817813;9502.382345147544;9555.9044409555;9648.903510964801;9722.125008749246;10548;10795.460226988462;10896.400697961371;11092.833607495733;11097.778044439228;9391.20174785151;9526.190273826525;9604.759881002752;9833.459159746282;10329.793404131726;10158.898411015794;10293.228007899288;10353;10431.739206519898;10481.42352170638;9475.668351607661;9521.19069879068;9552.42685438876;9620.37467564606;9748.073932976356;8598.183172598594;8708.34687398435;8808.163224493663;8884.333674974274;9158.267338612763;8726.91273087261;8750.299976001777;8759.255463285692;8903.421277616933;8989.325800565115 01:57:19 INFO - PROCESS | 14377 | __end_tp_report 01:57:19 INFO - PROCESS | 14377 | __start_cc_report 01:57:19 INFO - PROCESS | 14377 | _x_x_mozilla_cycle_collect,1031 01:57:19 INFO - PROCESS | 14377 | __end_cc_report 01:57:19 INFO - PROCESS | 14377 | __startTimestamp1462093039311__endTimestamp 01:57:19 INFO - PROCESS | 14377 | 01:57:19 INFO - PROCESS | 14377 | ------- Summary: start ------- 01:57:19 INFO - PROCESS | 14377 | Number of tests: 6 01:57:19 INFO - PROCESS | 14377 | 01:57:19 INFO - PROCESS | 14377 | [#0] dojo.html Cycles:165 Average:4595.00 Median:4733.88 stddev:469.92 (9.9%) stddev-sans-first:443.45 01:57:19 INFO - PROCESS | 14377 | Values: 2561.2 2604.3 2635.6 2639.6 2647.0 4511.9 4639.0 4643.2 4643.4 4710.4 4580.7 4639.1 4675.1 4678.0 4678.6 4251.1 4269.5 4294.0 4339.8 4380.9 4301.2 4352.6 4382.3 4395.2 4399.0 4163.7 4255.0 4275.4 4291.5 4298.3 4224.2 4245.2 4248.5 4253.0 4256.9 4223.5 4225.4 4226.5 4228.4 4230.9 4534.7 4553.9 4588.7 4632.7 4654.9 4960.2 4980.6 4981.5 4983.5 5031.3 4827.2 4988.8 4995.9 5002.5 5013.6 4639.4 4660.0 4665.7 4702.2 4719.6 5056.0 5057.3 5059.8 5063.6 5128.3 4791.4 4828.1 4863.1 4886.6 4925.1 4896.8 4912.3 4917.2 4958.9 4966.1 4852.5 4875.8 4876.1 4882.8 4921.0 4817.3 4867.2 4927.7 4961.2 5045.8 4242.9 4264.4 4286.6 4299.7 4300.4 3700.3 3708.8 3714.7 3737.1 3746.5 4234.7 4312.2 4318.1 4329.1 4347.9 4908.8 4929.4 4990.5 5068.8 5077.4 4279.6 4282.9 4305.3 4318.1 4318.6 4494.3 4497.0 4504.5 4511.1 4547.0 4542.3 4654.1 4709.9 4735.5 4736.0 4992.5 5001.5 5002.5 5003.8 5056.1 4684.5 4690.6 4691.9 4696.3 4736.3 4743.7 4867.2 4878.5 4943.2 4947.8 4928.3 4940.2 4951.7 4975.4 4997.7 4733.9 4822.9 4827.7 4830.5 4881.8 4794.9 4845.7 4852.7 4885.4 4899.4 4742.1 4767.0 4783.4 4792.1 4832.6 4746.5 4825.5 4864.8 4892.4 4936.9 4758.7 4788.6 4796.8 4797.8 4837.5 01:57:19 INFO - PROCESS | 14377 | 01:57:19 INFO - PROCESS | 14377 | [#1] ext.html Cycles:180 Average:41647.41 Median:3445.10 stddev:75015.46 (2177.5%) stddev-sans-first:75162.48 01:57:19 INFO - PROCESS | 14377 | Values: 565.0 590.9 591.0 605.7 612.2 34723.0 36085.6 36092.8 36179.5 36215.8 36379.6 36886.3 36954.4 37052.4 37054.4 7437.5 7628.2 7629.9 7632.4 7636.4 7440.9 7557.1 7560.9 7568.5 7719.9 7672.0 7754.2 7754.5 7757.3 7761.3 7680.8 7749.1 7751.2 7752.4 7753.0 7597.3 7730.4 7731.1 7734.3 7736.3 35258.3 35700.6 35714.6 35856.3 35887.8 3111.9 3387.7 3526.7 3655.7 3865.5 25744.1 26022.1 26057.0 26125.5 26603.5 3403.4 3440.7 3449.5 3471.8 3673.7 242686.0 246030.0 246858.0 247346.8 247370.0 30908.2 31710.2 31752.0 31759.7 51090.2 32383.8 32395.7 32421.4 32509.8 32522.2 13334.5 13422.1 13537.7 13539.1 13540.6 11173.9 11224.2 11256.5 11259.1 11407.9 8123.7 8170.3 8196.7 8253.6 8264.3 3151.9 3159.5 3173.4 3179.0 3195.5 884.5 1004.9 1011.9 1018.3 1020.2 28607.0 28742.4 28967.7 29368.9 29403.9 968.5 976.4 1046.8 1081.8 1111.9 15006.8 15376.6 15512.3 15656.5 15764.9 360353.0 363442.0 367623.0 367880.0 368134.0 49620.0 50379.5 50409.0 50595.2 50622.7 1146.8 1157.5 1188.1 1221.1 1271.3 25249.6 26046.0 26078.7 26555.3 27552.9 35455.8 35565.5 35813.1 35828.5 35848.1 220686.0 221852.0 222369.0 222695.0 223140.0 20939.5 23453.4 24308.9 25999.4 26447.6 36145.6 37116.4 37233.6 37409.3 37692.8 31526.8 31752.0 32439.0 32594.5 33234.8 34133.5 35027.6 35426.5 35620.6 36134.0 35019.0 35134.0 35832.8 35833.6 35848.8 31267.4 31867.7 32036.2 32121.0 32308.7 24446.3 24727.0 24801.5 24835.6 24928.0 01:57:19 INFO - PROCESS | 14377 | 01:57:19 INFO - PROCESS | 14377 | [#2] jquery.html Cycles:180 Average:24403.76 Median:5309.88 stddev:67989.44 (1280.4%) stddev-sans-first:68156.24 01:57:19 INFO - PROCESS | 14377 | Values: 376.4 380.1 384.4 386.2 387.7 15851.6 16173.8 17223.4 17237.7 17245.0 11185.4 16090.0 16825.7 16834.2 16836.4 3471.8 4493.1 4650.8 4651.1 4658.2 3620.9 5122.2 5394.8 5394.9 5397.8 5313.8 5374.1 5375.7 5376.3 5395.5 5194.7 5306.0 5334.4 5335.1 5338.9 5105.4 5121.5 5129.4 5144.5 5156.5 12081.7 12204.1 12233.9 12294.9 12341.0 1794.7 1803.2 1829.0 1901.8 1904.6 9236.3 9316.2 9670.8 9892.4 13176.2 1762.9 1833.8 1846.3 1867.4 1894.4 67589.3 69690.7 71243.3 71993.9 72347.6 9993.3 10125.6 10170.2 10182.6 10290.1 13901.6 13982.3 13993.2 13997.8 14002.9 7358.0 7449.3 7453.0 7523.6 7532.2 7136.4 7188.4 7281.5 7289.5 7296.3 4272.0 4314.7 4388.2 4395.8 4466.0 1668.7 1741.0 1762.3 1823.9 1826.5 780.1 853.7 894.9 911.2 916.7 16218.0 16233.9 16463.3 16855.9 17153.0 849.5 887.7 912.6 921.6 943.0 9022.5 9481.8 9547.6 9600.5 9672.7 398179.0 402826.0 415772.0 420261.0 421725.0 77344.6 79611.6 79676.6 79739.6 79766.2 920.5 939.0 950.7 952.0 954.8 14802.9 14925.9 14996.6 15004.2 15340.2 32476.7 33620.0 34431.8 34816.0 35277.3 47331.0 48786.0 49173.0 49414.3 49499.5 7467.6 7534.5 7599.0 7609.3 7671.4 6740.0 8271.4 9868.3 10516.2 10770.5 8781.0 8856.2 8901.7 8992.4 9420.5 9629.5 9668.1 9740.2 9789.8 9808.9 8924.5 9153.4 9189.2 9231.7 9495.5 7475.3 7509.0 7523.4 7582.3 7631.9 8153.9 9058.1 9138.5 9185.2 9321.6 01:57:19 INFO - PROCESS | 14377 | 01:57:19 INFO - PROCESS | 14377 | [#3] mootools.html Cycles:180 Average:5086.25 Median:5414.12 stddev:2786.15 (51.5%) stddev-sans-first:2778.90 01:57:19 INFO - PROCESS | 14377 | Values: 1231.9 1421.1 1485.2 1613.4 1776.4 7278.0 7645.1 7663.1 7669.5 7670.9 7449.4 7608.0 7613.5 7624.2 7634.3 1932.8 1988.8 1989.5 2177.3 2204.2 2193.2 2256.7 2261.5 2262.7 2263.1 2165.0 2184.5 2194.7 2196.3 2214.3 1884.9 2128.3 2192.2 2196.9 2197.8 2218.7 2248.6 2249.7 2252.4 2253.3 7504.0 7534.9 7546.7 7547.8 7554.6 4471.9 4652.4 4666.7 4677.6 4678.7 2755.2 2800.2 2900.9 2917.1 2925.7 889.8 945.0 946.9 1761.1 1783.9 9719.1 9814.6 9820.3 9840.0 9854.1 3916.1 4024.5 4073.3 4098.8 4102.4 7946.5 8008.1 8019.5 8020.0 8022.7 4470.8 4558.0 4558.4 4579.7 4586.3 3798.4 4219.3 4231.2 4290.6 4338.6 3472.0 3557.6 3588.2 3589.3 3590.2 1053.5 1059.1 1065.5 1072.2 1077.7 866.6 866.8 882.3 908.5 911.9 5335.3 5368.3 5415.9 5556.9 5605.0 379.7 402.3 410.8 410.9 412.1 3576.9 3724.0 3748.3 3785.7 3788.3 9239.7 9541.6 9712.6 9740.1 9763.3 9616.5 9696.8 9706.0 9726.2 9735.3 7196.4 7235.2 7352.2 7392.0 7478.3 5350.4 5412.4 5419.4 5458.5 5543.5 8844.3 8877.8 8966.0 9032.5 9043.4 8504.4 8651.3 8718.2 8725.1 8971.2 5767.7 6443.1 6671.6 6678.6 6803.8 7437.5 7478.0 7534.9 7536.7 7550.4 6439.3 6810.1 6851.2 6945.2 6947.8 6718.8 6729.0 6797.4 6859.6 6909.6 6424.5 6440.0 6498.2 6563.2 6578.2 4725.9 4824.0 4920.7 4944.3 4967.8 4824.5 4828.0 4917.0 4969.4 4993.1 01:57:19 INFO - PROCESS | 14377 | 01:57:19 INFO - PROCESS | 14377 | [#4] prototype.html Cycles:180 Average:4138.37 Median:4654.24 stddev:1199.99 (25.8%) stddev-sans-first:1168.29 01:57:19 INFO - PROCESS | 14377 | Values: 301.5 304.8 304.9 307.6 310.9 4622.7 4657.9 4683.0 4699.0 4726.8 4628.5 4636.3 4637.1 4654.1 4669.5 3508.9 3619.7 3626.6 3627.5 3658.6 3561.3 3652.9 3714.4 3714.8 3739.3 3644.1 3695.8 3707.5 3712.3 3733.7 3594.7 3661.7 3684.5 3694.1 3704.9 3299.5 3301.4 3307.6 3309.4 3317.4 4418.9 4428.1 4442.9 4443.6 4458.3 4181.3 4188.7 4191.7 4200.8 4209.1 4686.0 4776.8 4810.7 4827.9 4834.2 3595.4 3600.9 3610.0 3611.3 3617.3 5083.2 5090.2 5093.9 5100.6 5106.5 3378.9 3671.9 3675.9 3676.9 3690.5 3629.1 3632.6 3638.7 3651.9 3655.5 4112.5 4116.7 4117.3 4128.9 4132.2 4834.5 4863.6 4880.3 4898.2 4921.3 1300.2 1317.4 1334.8 1339.1 1341.4 884.3 888.5 901.5 910.1 913.6 4179.9 4264.3 4391.0 4403.3 4426.7 5006.2 5027.3 5060.7 5081.5 5092.2 4357.9 4388.8 4390.6 4390.9 4395.8 2751.8 2859.9 2870.6 2875.4 2877.8 5053.8 5091.4 5094.2 5134.4 5135.3 5324.7 5562.8 5563.2 5563.5 5590.1 5060.9 5082.8 5092.6 5115.2 5127.6 5371.6 5375.7 5385.0 5426.8 5433.6 4758.3 5039.1 5309.6 5323.9 5347.8 4816.0 4833.4 4836.6 4836.9 4842.8 3562.2 3583.4 3595.4 3597.3 3603.1 4808.4 5082.7 5097.1 5104.2 5112.9 4873.6 4943.0 4952.4 4953.5 5005.0 4911.1 4931.9 4937.4 4946.3 4956.7 4610.4 4776.5 4840.6 4843.2 4861.9 4654.3 4772.1 4944.6 4957.2 4964.1 4881.6 4896.6 4911.8 4913.3 4913.5 01:57:19 INFO - PROCESS | 14377 | 01:57:19 INFO - PROCESS | 14377 | [#5] yui.html Cycles:180 Average:12337.34 Median:25558.56 stddev:14202.63 (55.6%) stddev-sans-first:14215.26 01:57:19 INFO - PROCESS | 14377 | Values: 630.6 641.9 759.1 773.6 781.3 11340.3 11514.7 11564.5 11598.2 12057.6 11995.9 12063.6 12077.5 12091.5 12150.0 623.7 760.7 761.2 766.0 769.0 769.7 770.0 770.1 773.3 777.7 816.2 816.3 816.3 818.7 819.5 663.0 811.8 814.0 827.1 841.8 603.4 610.0 617.8 619.2 619.6 12333.6 12425.8 12442.3 12445.8 12467.6 11915.2 12340.4 12542.4 12781.3 12806.5 9888.7 9903.7 9949.4 10056.8 10098.2 3288.0 3307.9 3326.0 3355.4 3408.3 41521.4 41611.2 41739.8 41939.2 42001.8 9614.3 9757.0 10057.0 10066.1 10095.2 15868.2 15931.6 15946.8 16023.3 16026.5 6198.2 6276.6 6356.0 6435.0 6540.2 3599.0 3606.1 3624.9 3715.8 3717.9 2840.5 2894.1 2905.5 2910.6 2912.8 476.8 498.8 505.4 508.3 510.8 536.9 565.0 579.6 582.5 589.7 7408.6 7410.6 7489.8 7666.9 7675.9 457.9 505.3 567.7 584.9 593.2 3427.9 3512.0 3575.7 3583.6 3589.6 50611.7 51101.5 52255.7 52459.0 52640.5 45166.8 46823.0 46885.5 47134.7 47433.3 42437.2 42902.0 42984.0 43316.8 43538.3 7429.3 7560.3 7584.4 7739.4 7739.7 28787.7 28902.1 29245.6 29851.7 29915.1 37498.6 37889.2 38115.8 39094.6 39103.2 9190.3 9502.4 9555.9 9648.9 9722.1 10548.0 10795.5 10896.4 11092.8 11097.8 9391.2 9526.2 9604.8 9833.5 10329.8 10158.9 10293.2 10353.0 10431.7 10481.4 9475.7 9521.2 9552.4 9620.4 9748.1 8598.2 8708.3 8808.2 8884.3 9158.3 8726.9 8750.3 8759.3 8903.4 8989.3 01:57:19 INFO - PROCESS | 14377 | -------- Summary: end -------- 01:57:19 INFO - PROCESS | 14377 | 01:57:20 INFO - TEST-INFO | 14377: exit 0 01:57:20 INFO - TEST-OK | dromaeo_css | took 1117482ms 01:57:20 INFO - TEST-START | kraken 01:57:20 INFO - operating with platform_type : linux_ 01:57:20 INFO - Initialising browser for kraken test... 01:57:20 INFO - TEST-INFO | started process 14554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfVC5_F/profile http://localhost:58405/getInfo.html) 01:57:24 INFO - PROCESS | 14554 | __metrics Screen width/height:1600/1200 01:57:24 INFO - PROCESS | 14554 | colorDepth:24 01:57:24 INFO - PROCESS | 14554 | Browser inner width/height: 1024/697 01:57:24 INFO - PROCESS | 14554 | __metrics 01:57:24 ERROR - PROCESS | 14554 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:57:25 INFO - TEST-INFO | 14554: exit 0 01:57:25 INFO - Browser initialized. 01:57:25 INFO - Running cycle 1/1 for kraken test... 01:57:25 INFO - TEST-INFO | started process 14634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfVC5_F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:37 INFO - PROCESS | 14634 | RSS: Main: 156303360 01:57:37 INFO - PROCESS | 14634 | 01:57:40 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58405/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:41 INFO - PROCESS | 14634 | RSS: Main: 210649088 01:57:41 INFO - PROCESS | 14634 | 01:57:44 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58405/tests/kraken/driver.html?testName=audio-dft) 01:57:44 INFO - PROCESS | 14634 | RSS: Main: 196694016 01:57:44 INFO - PROCESS | 14634 | 01:57:48 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58405/tests/kraken/driver.html?testName=audio-fft) 01:57:48 INFO - PROCESS | 14634 | RSS: Main: 265752576 01:57:48 INFO - PROCESS | 14634 | 01:57:50 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58405/tests/kraken/driver.html?testName=audio-oscillator) 01:57:51 INFO - PROCESS | 14634 | RSS: Main: 174800896 01:57:51 INFO - PROCESS | 14634 | 01:57:53 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:57:54 INFO - PROCESS | 14634 | RSS: Main: 179277824 01:57:54 INFO - PROCESS | 14634 | 01:57:57 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58405/tests/kraken/driver.html?testName=imaging-darkroom) 01:57:58 INFO - PROCESS | 14634 | RSS: Main: 215396352 01:57:58 INFO - PROCESS | 14634 | 01:58:01 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58405/tests/kraken/driver.html?testName=imaging-desaturate) 01:58:02 INFO - PROCESS | 14634 | RSS: Main: 216211456 01:58:02 INFO - PROCESS | 14634 | 01:58:04 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58405/tests/kraken/driver.html?testName=json-parse-financial) 01:58:05 INFO - PROCESS | 14634 | RSS: Main: 216698880 01:58:05 INFO - PROCESS | 14634 | 01:58:07 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:58:07 INFO - PROCESS | 14634 | RSS: Main: 201609216 01:58:07 INFO - PROCESS | 14634 | 01:58:09 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58405/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:58:10 INFO - PROCESS | 14634 | RSS: Main: 203862016 01:58:10 INFO - PROCESS | 14634 | 01:58:12 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:58:13 INFO - PROCESS | 14634 | RSS: Main: 218243072 01:58:13 INFO - PROCESS | 14634 | 01:58:16 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:58:16 INFO - PROCESS | 14634 | RSS: Main: 225906688 01:58:16 INFO - PROCESS | 14634 | 01:58:19 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:58:20 INFO - PROCESS | 14634 | RSS: Main: 220409856 01:58:20 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | Cycle 1(1): loaded http://localhost:58405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58405/tests/kraken/driver.html?testName=ai-astar) 01:58:22 INFO - PROCESS | 14634 | RSS: Main: 283860992 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | __start_tp_report 01:58:22 INFO - PROCESS | 14634 | _x_x_mozilla_page_load 01:58:22 INFO - PROCESS | 14634 | _x_x_mozilla_page_load_details 01:58:22 INFO - PROCESS | 14634 | |i|pagename|runs| 01:58:22 INFO - PROCESS | 14634 | |0;ai-astar;111;115;109;114;113;113;102;113;113;114 01:58:22 INFO - PROCESS | 14634 | |1;audio-beat-detection;169;135;170;203;145;167;175;134;190;134 01:58:22 INFO - PROCESS | 14634 | |2;audio-dft;162;161;163;161;162;162;161;162;163;160 01:58:22 INFO - PROCESS | 14634 | |3;audio-fft;75;75;122;118;80;78;82;125;108;76 01:58:22 INFO - PROCESS | 14634 | |4;audio-oscillator;94;96;156;93;94;94;153;93;93;143 01:58:22 INFO - PROCESS | 14634 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;116;116;117 01:58:22 INFO - PROCESS | 14634 | |6;imaging-darkroom;146;147;145;147;145;145;145;146;146;147 01:58:22 INFO - PROCESS | 14634 | |7;imaging-desaturate;95;95;95;95;94;95;97;94;95;94 01:58:22 INFO - PROCESS | 14634 | |8;json-parse-financial;69;68;69;69;69;70;69;94;66;67 01:58:22 INFO - PROCESS | 14634 | |9;json-stringify-tinderbox;66;65;65;66;65;65;66;66;66;66 01:58:22 INFO - PROCESS | 14634 | |10;stanford-crypto-aes;81;81;82;81;91;82;83;82;84;83 01:58:22 INFO - PROCESS | 14634 | |11;stanford-crypto-ccm;136;133;137;134;132;133;130;130;165;133 01:58:22 INFO - PROCESS | 14634 | |12;stanford-crypto-pbkdf2;182;174;180;177;176;174;175;173;174;179 01:58:22 INFO - PROCESS | 14634 | |13;stanford-crypto-sha256-iterative;73;76;74;76;74;75;74;72;73;72 01:58:22 INFO - PROCESS | 14634 | __end_tp_report 01:58:22 INFO - PROCESS | 14634 | __start_cc_report 01:58:22 INFO - PROCESS | 14634 | _x_x_mozilla_cycle_collect,1895 01:58:22 INFO - PROCESS | 14634 | __end_cc_report 01:58:22 INFO - PROCESS | 14634 | __startTimestamp1462093102355__endTimestamp 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | ------- Summary: start ------- 01:58:22 INFO - PROCESS | 14634 | Number of tests: 14 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.80 (3.4%) stddev-sans-first:4.02 01:58:22 INFO - PROCESS | 14634 | Values: 111.0 115.0 109.0 114.0 113.0 113.0 102.0 113.0 113.0 114.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#1] audio-beat-detection Cycles:10 Average:162.20 Median:169.50 stddev:24.40 (14.4%) stddev-sans-first:25.75 01:58:22 INFO - PROCESS | 14634 | Values: 169.0 135.0 170.0 203.0 145.0 167.0 175.0 134.0 190.0 134.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 01:58:22 INFO - PROCESS | 14634 | Values: 162.0 161.0 163.0 161.0 162.0 162.0 161.0 162.0 163.0 160.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.50 stddev:21.50 (28.5%) stddev-sans-first:21.69 01:58:22 INFO - PROCESS | 14634 | Values: 75.0 75.0 122.0 118.0 80.0 78.0 82.0 125.0 108.0 76.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:93.50 stddev:27.64 (29.6%) stddev-sans-first:28.63 01:58:22 INFO - PROCESS | 14634 | Values: 94.0 96.0 156.0 93.0 94.0 94.0 153.0 93.0 93.0 143.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:58:22 INFO - PROCESS | 14634 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 01:58:22 INFO - PROCESS | 14634 | Values: 146.0 147.0 145.0 147.0 145.0 145.0 145.0 146.0 146.0 147.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 01:58:22 INFO - PROCESS | 14634 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 97.0 94.0 95.0 94.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#8] json-parse-financial Cycles:10 Average:71.00 Median:69.00 stddev:8.16 (11.8%) stddev-sans-first:8.63 01:58:22 INFO - PROCESS | 14634 | Values: 69.0 68.0 69.0 69.0 69.0 70.0 69.0 94.0 66.0 67.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 01:58:22 INFO - PROCESS | 14634 | Values: 66.0 65.0 65.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.50 stddev:2.98 (3.6%) stddev-sans-first:3.07 01:58:22 INFO - PROCESS | 14634 | Values: 81.0 81.0 82.0 81.0 91.0 82.0 83.0 82.0 84.0 83.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:133.50 stddev:10.33 (7.7%) stddev-sans-first:10.95 01:58:22 INFO - PROCESS | 14634 | Values: 136.0 133.0 137.0 134.0 132.0 133.0 130.0 130.0 165.0 133.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:176.50 stddev:3.03 (1.7%) stddev-sans-first:2.44 01:58:22 INFO - PROCESS | 14634 | Values: 182.0 174.0 180.0 177.0 176.0 174.0 175.0 173.0 174.0 179.0 01:58:22 INFO - PROCESS | 14634 | 01:58:22 INFO - PROCESS | 14634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.00 stddev:1.45 (2.0%) stddev-sans-first:1.50 01:58:22 INFO - PROCESS | 14634 | Values: 73.0 76.0 74.0 76.0 74.0 75.0 74.0 72.0 73.0 72.0 01:58:22 INFO - PROCESS | 14634 | -------- Summary: end -------- 01:58:22 INFO - PROCESS | 14634 | 01:58:23 INFO - TEST-INFO | 14634: exit 0 01:58:23 INFO - TEST-OK | kraken | took 63347ms 01:58:23 INFO - SUITE-END | took 1180s 01:58:23 INFO - Completed test suite (00:19:40) 01:58:23 INFO - javascript benchmark 01:58:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.1804222648752, 2604.257786530839, 2635.644188034616, 2639.564471862143, 2647.02060237712, 4511.887202819931, 4638.97680511597, 4643.210654188788, 4643.396358473398, 4710.364100846389, 4580.702254353465, 4639.141758774629, 4675.088357770236, 4677.953220467794, 4678.5789278964885, 4251.0860165064505, 4269.487661480626, 4293.957060429402, 4339.804708788096, 4380.8685739427865, 4301.161273551658, 4352.564743525654, 4382.298832186851, 4395.1649186654595, 4399.0, 4163.708540402173, 4255.0, 4275.358696195564, 4291.485021797404, 4298.269294219975, 4224.197402493547, 4245.150969806051, 4248.490181178247, 4252.957470425287, 4256.893577660552, 4223.535411104776, 4225.408442818008, 4226.492820861486, 4228.429162063113, 4230.915381692349, 4534.7052441591195, 4553.886152846172, 4588.655850811202, 4632.72203667781, 4654.930176047362, 4960.23116416956, 4980.576650984671, 4981.501849815026, 4983.526564976321, 5031.295618613397, 4827.155247831651, 4988.800447982077, 4995.925061124086, 5002.52476014778, 5013.6490445668815, 4639.373684552576, 4659.976700116477, 4665.743384113838, 4702.200625893538, 4719.622430205575, 5056.0, 5057.317262169634, 5059.822906198266, 5063.5695965843315, 5128.25640282157, 4791.401074865642, 4828.106800241966, 4863.124637565202, 4886.633502487328, 4925.088858561177, 4896.779644915988, 4912.287718280901, 4917.188663870493, 4958.851234462972, 4966.056449274699, 4852.51474852519, 4875.780589873464, 4876.097921884463, 4882.847612008894, 4920.950790492049, 4817.2774083887, 4867.221244600847, 4927.679700819435, 4961.156603377434, 5045.84862454127, 4242.915141697149, 4264.360345948133, 4286.592773686495, 4299.656027517791, 4300.440942677432, 3700.3154416433044, 3708.7589306694977, 3714.665680088805, 3737.0844143185095, 3746.4942232798767, 4234.724742891703, 4312.180685669713, 4318.050028993616, 4329.112531930947, 4347.891302717394, 4908.779104940286, 4929.359183306147, 4990.500949905053, 5068.82259120929, 5077.365329333833, 4279.550647182064, 4282.914341713148, 4305.268104422193, 4318.093200427883, 4318.589733975267, 4494.258447356215, 4496.977515112403, 4504.459464864171, 4511.075229577994, 4547.0, 4542.3413605027745, 4654.092451971833, 4709.905801883943, 4735.502772208868, 4735.952640473689, 4992.525710057539, 5001.474845141353, 5002.52476014778, 5003.77483013258, 5056.064628043824, 4684.48470668233, 4690.554397332248, 4691.929621055755, 4696.342512048384, 4736.313234581035, 4743.667943244078, 4867.1969125093965, 4878.512148785093, 4943.184374578154, 4947.777350019186, 4928.310036594808, 4940.184869496493, 4951.653384263067, 4975.353204083446, 4997.725125118153, 4733.881652958704, 4822.8794280143275, 4827.734474603931, 4830.492798256273, 4881.829135980223, 4794.880127996828, 4845.709257444564, 4852.73309967941, 4885.438174609965, 4899.363082799213, 4742.07529531738, 4766.95233047679, 4783.425988881357, 4792.137415265286, 4832.613390928647, 4746.525347465225, 4825.541573550507, 4864.829730959399, 4892.437369702529, 4936.851894443173, 4758.666893317434, 4788.569028787426, 4796.784144713426, 4797.760111994457, 4837.467878533429], "value": 4565.652921023153, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.9887002259952, 590.8995470769969, 590.9615874968127, 605.7062324772485, 612.2438788096703, 34723.0, 36085.63914360859, 36092.819535902316, 36179.4573081404, 36215.818920905425, 36379.63620363796, 36886.262274754554, 36954.44568331477, 37052.44421333682, 37054.444183337204, 7437.5165614235175, 7628.199039100898, 7629.885551716701, 7632.389408847279, 7636.427267954898, 7440.888386674177, 7557.05536807899, 7560.924390756105, 7568.508046976929, 7719.884201736979, 7672.0, 7754.185810489874, 7754.495957762756, 7757.301842834144, 7761.3402860756905, 7680.769576912701, 7749.070111586618, 7751.186125456802, 7752.418568607321, 7752.961235193844, 7597.278258565483, 7730.420218483636, 7731.072271327421, 7734.303912647889, 7736.34241089508, 35258.29483410317, 35700.64299356999, 35714.642853571655, 35856.28287434263, 35887.82056089729, 3111.9066428007195, 3387.661233876617, 3526.7354948378975, 3655.689266412358, 3865.4974853269177, 25744.098956536618, 26022.089226877157, 26056.95772169111, 26125.477490450274, 26603.46793064128, 3403.3533628610485, 3440.7247420206572, 3449.482577613353, 3471.8090505022215, 3673.669369756735, 242686.0, 246030.0, 246858.0, 247346.7632661843, 247370.0, 30908.22729431782, 31710.207244819063, 31752.0, 31759.682403175673, 51090.23364649533, 32383.838080809917, 32395.67604323974, 32421.351572968408, 32509.837450812596, 32522.186945326084, 13334.466621335037, 13422.127561708458, 13537.729245415037, 13539.11995720275, 13540.59378218655, 11173.888261117447, 11224.158188135922, 11256.549738010552, 11259.099272058216, 11407.942960285145, 8123.6750529978135, 8170.305524030405, 8196.67213311461, 8253.628586713492, 8264.256216940505, 3151.936961260762, 3159.4786860167815, 3173.444647186733, 3178.952315715266, 3195.5366471861917, 884.4516399832016, 1004.9497525123861, 1011.9494025298706, 1018.332991890313, 1020.2348238820884, 28607.0, 28742.425151496853, 28967.730326295383, 29368.853155734512, 29403.852980735388, 968.5205823117602, 976.4434272464769, 1046.8325067989085, 1081.7836432713489, 1111.8721347045032, 15006.849931500763, 15376.615584610474, 15512.301946412439, 15656.530304090895, 15764.921175394278, 360353.0, 363442.0, 367623.0, 367880.0, 368134.0, 49620.0, 50379.49620503822, 50409.0, 50595.241071383956, 50622.74688626533, 1146.7821113988316, 1157.4733496259182, 1188.0851744157123, 1221.0841868598372, 1271.281725824906, 25249.621255681548, 26046.0, 26078.73921260763, 26555.33611659724, 27552.86223568869, 35455.82272088623, 35565.466518002766, 35813.1046723834, 35828.462573061945, 35848.103797405274, 220686.0, 221852.0, 222369.0, 222695.0, 223140.0, 20939.476513087295, 23453.41366465852, 24308.87845560761, 25999.350016249744, 26447.60328595111, 36145.63854361423, 37116.443253350684, 37233.6276637241, 37409.25181496409, 37692.81153594214, 31526.842365788943, 31752.0, 32439.0, 32594.51108233331, 33234.83382583072, 34133.48799768055, 35027.649723503455, 35426.468602971494, 35620.643793561736, 36134.0, 35019.0, 35134.0, 35832.820835895654, 35833.64166358407, 35848.8207558971, 31267.37465250728, 31867.6813231874, 32036.19909502281, 32121.0, 32308.676913231506, 24446.26661200167, 24727.0, 24801.525879028526, 24835.627465588394, 24928.0], "value": 15857.625931786806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4353469795307, 380.1048530710177, 384.3600405325132, 386.17744204843694, 387.6549870615155, 15851.603709907244, 16173.838261617395, 17223.397181098662, 17237.741433878502, 17245.0, 11185.44072796361, 16090.0, 16825.663486730256, 16834.24245908934, 16836.410725624606, 3471.7743346682387, 4493.101379724052, 4650.813967441299, 4651.1162879053045, 4658.1848176568965, 3620.913725882238, 5122.231665250205, 5394.838154855341, 5394.946050539484, 5397.811076612319, 5313.760880760356, 5374.059539580578, 5375.704336261504, 5376.274202982587, 5395.460453954613, 5194.740262986855, 5306.0, 5334.359876814807, 5335.0663633864115, 5338.91991620126, 5105.387353517602, 5121.4622464641425, 5129.435762066169, 5144.459831717691, 5156.484351564851, 12081.697957551043, 12204.145709800228, 12233.93883030588, 12294.938525307405, 12341.0, 1794.6590147871993, 1803.1615298886081, 1828.9908550457296, 1901.8003109673423, 1904.552430178907, 9236.307276954256, 9316.161545460942, 9670.806583868354, 9892.406455612687, 13176.209427434289, 1762.9206685699173, 1833.8166183381688, 1846.2707230643955, 1867.411765293928, 1894.3748562974185, 67589.3241067588, 69690.65154674245, 71243.28756712418, 71993.9208510809, 72347.63826180836, 9993.250506211918, 10125.59497620087, 10170.152357339957, 10182.643607473703, 10290.073893349634, 13901.58295251144, 13982.300884955712, 13993.160410375207, 13997.790033149511, 14002.929985350009, 7358.00666909971, 7449.255074492507, 7453.0, 7523.570144152972, 7532.246775322534, 7136.393406560397, 7188.353048225685, 7281.490295679251, 7289.5261807982315, 7296.343329100407, 4271.9786401067795, 4314.71954322968, 4388.166248412791, 4395.7582332972, 4466.0, 1668.7163182259046, 1741.0304505726963, 1762.2950819672233, 1823.8996855172827, 1826.452064380707, 780.1457404142454, 853.6628031927354, 894.9239314658197, 911.1799380557419, 916.7112359606703, 16218.0, 16233.918830406008, 16463.34146634145, 16855.915720421566, 17153.0, 849.4860609331389, 887.6937456577471, 912.6075787411344, 921.5714692667941, 943.0239701908491, 9022.548872556346, 9481.762955926019, 9547.570359333846, 9600.471974041495, 9672.661456848977, 398179.0, 402826.0, 415772.0, 420261.0, 421725.0, 77344.61327693438, 79611.60194198992, 79676.60161699154, 79739.60130199311, 79766.20233797588, 920.5075284722775, 939.0, 950.6862735297335, 952.0194199974038, 954.7994921066654, 14802.851971480148, 14925.850741492446, 14996.550103496913, 15004.174770387734, 15340.232988350761, 32476.675233247366, 33620.0, 34431.827840860635, 34816.0, 35277.29445411129, 47331.0, 48786.0, 49173.0, 49414.25878611895, 49499.50500494949, 7467.551946883204, 7534.54792712439, 7599.0, 7609.315161635479, 7671.424643151898, 6740.0, 8271.379646526655, 9868.259880508847, 10516.15870730355, 10770.515326810155, 8781.0, 8856.202941735275, 8901.688440904538, 8992.370534062553, 9420.528973551433, 9629.470379129216, 9668.129868311886, 9740.198063358019, 9789.804203916025, 9808.9019109808, 8924.509151996703, 9153.405028673114, 9189.172974432333, 9231.723048308562, 9495.477748723886, 7475.289847464483, 7509.0, 7523.435742319458, 7582.317591416799, 7631.855221716565, 8153.918460815553, 9058.094190580889, 9138.543072846463, 9185.173334399937, 9321.580528876353], "value": 7900.033064369343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.9199252048622, 1421.0549984260467, 1485.2425263115808, 1613.3949768836687, 1776.360510216321, 7278.0174676418665, 7645.120811106724, 7663.080430348352, 7669.50148240364, 7670.92329076709, 7449.441291903116, 7608.0, 7613.467057305991, 7624.237576242373, 7634.274743899335, 1932.8357089647398, 1988.7712913015043, 1989.512569420494, 2177.3032629558547, 2204.151401710337, 2193.1885202475105, 2256.717910261217, 2261.457250259942, 2262.739784924738, 2263.106073101124, 2165.036558731365, 2184.541246338263, 2194.7476040255337, 2196.2752291743686, 2214.26929113393, 1884.8586356023216, 2128.3082998025548, 2192.166976548909, 2196.9121235150574, 2197.8021978021893, 2218.7337519497764, 2248.640217565198, 2249.718785151856, 2252.40311317501, 2253.3352660965056, 7504.0, 7534.886976695354, 7546.660400281946, 7547.811304717371, 7554.622268886534, 4471.8658440246845, 4652.418447694038, 4666.673332866701, 4677.6257899367965, 4678.7426691531955, 2755.2285360099204, 2800.173948685143, 2900.912972610825, 2917.124862541229, 2925.736683698456, 889.7820034091624, 945.0171821305834, 946.857971304303, 1761.1018380625974, 1783.9108044597717, 9719.125278724949, 9814.607415703364, 9820.263480239011, 9840.0, 9854.113129818279, 3916.060145565101, 4024.4566983457444, 4073.348264277701, 4098.7950602469755, 4102.384642303678, 7946.523208607502, 8008.119106898236, 8019.518828870287, 8020.0, 8022.719204827803, 4470.798814053375, 4557.977210113928, 4558.430196225472, 4579.679422440464, 4586.289125185602, 3798.3542797724454, 4219.3249080147025, 4231.217224813419, 4290.570942905684, 4338.60952514269, 3472.0, 3557.573091229069, 3588.246468241646, 3589.3000864831106, 3590.2460483298278, 1053.5259133390005, 1059.1156384418941, 1065.5471424644495, 1072.1690689715533, 1077.7197928538637, 866.6230189867301, 866.7616405488541, 882.34706317326, 908.4685459006555, 911.9452832830051, 5335.306410166731, 5368.2752828367675, 5415.891682166334, 5556.888862222814, 5605.0, 379.7322887364401, 402.3287501548371, 410.8089738271718, 410.8890599538108, 412.13451751321986, 3576.910577235538, 3724.0, 3748.2878253131817, 3785.73499855013, 3788.318102741478, 9239.676611318706, 9541.618335266512, 9712.611495540099, 9740.074692904163, 9763.316567840184, 9616.51917404127, 9696.75758106053, 9705.980872008478, 9726.221902247804, 9735.269854760922, 7196.352328290479, 7235.167955685059, 7352.19125896151, 7392.039034925425, 7478.252174782587, 5350.411454739898, 5412.350517937873, 5419.376771671308, 5458.4541545845095, 5543.501084902378, 8844.292456603585, 8877.822443551222, 8965.98265390282, 9032.45805251687, 9043.366964312436, 8504.362172836938, 8651.264642505206, 8718.215360617574, 8725.083866194213, 8971.16091201289, 5767.68277744728, 6443.097966284818, 6671.566348187546, 6678.565893216925, 6803.829904252433, 7437.51656142349, 7478.027856378636, 7534.886976695244, 7536.7362142324755, 7550.35821955118, 6439.259485159267, 6810.148731408574, 6851.246362899978, 6945.236024037453, 6947.756828510978, 6718.798436046926, 6729.0, 6797.354251346114, 6859.588424694534, 6909.585424874524, 6424.518161138027, 6440.001799721051, 6498.187726534184, 6563.212414510289, 6578.177727784027, 4725.881852953704, 4823.95176048235, 4920.704757714549, 4944.28307895346, 4967.801287948441, 4824.49342818999, 4828.0, 4916.9754151230445, 4969.35398398206, 4993.126202914548], "value": 4071.2187230141294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.5100461749657, 304.7546724886467, 304.9405365953639, 307.60472792461684, 310.89274200400854, 4622.745748983804, 4657.930131048032, 4683.016566521031, 4698.953010469894, 4726.834560790373, 4628.472604040667, 4636.2581986882105, 4637.072585482909, 4654.138984287909, 4669.486356500782, 3508.9298214035766, 3619.7285203609704, 3626.6373362663653, 3627.52842130524, 3658.5609726832818, 3561.269939662376, 3652.9223878955772, 3714.4428335749585, 3714.7771133732062, 3739.3456145174623, 3644.125409901631, 3695.8336874840697, 3707.518022657064, 3712.257548490299, 3733.701303895682, 3594.658507441789, 3661.743677942545, 3684.5446048810704, 3694.07648087978, 3704.944425833615, 3299.5215693724276, 3301.4387554115856, 3307.6361600223954, 3309.3712194682935, 3317.4194515959853, 4418.917365245503, 4428.070105277896, 4442.911141777146, 4443.577860103285, 4458.328126952393, 4181.310083836163, 4188.68584856137, 4191.7275377100395, 4200.810963506619, 4209.137126889011, 4685.976570117162, 4776.80892764289, 4810.7113573185725, 4827.903441931142, 4834.202356611155, 3595.388783906742, 3600.873969411058, 3609.963900360989, 3611.2777444511203, 3617.3488772021024, 5083.161278389061, 5090.2110172922885, 5093.923591146136, 5100.5919526438165, 5106.4893510648635, 3378.915527111793, 3671.9082022949106, 3675.852965881335, 3676.9080772980888, 3690.4648825920626, 3629.1108678373967, 3632.6387847899077, 3638.7452878298263, 3651.926961460756, 3655.524781778352, 4112.527059388149, 4116.732412393185, 4117.300058989979, 4128.91742165155, 4132.173565286895, 4834.540718631724, 4863.586595139382, 4880.292357608198, 4898.24077268024, 4921.335619691367, 1300.2458574027041, 1317.3676635214958, 1334.753070681927, 1339.1228745171927, 1341.4097796969302, 884.3411658314596, 888.4891187567175, 901.4726385064679, 910.0717268386209, 913.6254135804288, 4179.895502612399, 4264.253755592821, 4390.978045109754, 4403.295472724413, 4426.712263702849, 5006.199008158677, 5027.271045698353, 5060.696358218519, 5081.466446023114, 5092.210707340369, 4357.869263922087, 4388.780560971939, 4390.648748100144, 4390.912181756347, 4395.8021889014435, 2751.761707231714, 2859.9285017874718, 2870.598116263725, 2875.396166804994, 2877.812942158753, 5053.823116190915, 5091.414487334004, 5094.159463688524, 5134.409542902539, 5135.281060651511, 5324.733763311819, 5562.833115006556, 5563.248961390242, 5563.471470210324, 5590.077637189818, 5060.949390506048, 5082.822101226439, 5092.6435149539175, 5115.232715092691, 5127.64106512548, 5371.62398632092, 5375.747672658142, 5385.0, 5426.755795989269, 5433.619646624698, 4758.286257061469, 5039.143345631178, 5309.58413921657, 5323.866903327448, 5347.812826551052, 4815.95184048155, 4833.41998960113, 4836.637252206169, 4836.863337115846, 4842.83050093245, 3562.1806984393215, 3583.4445660922597, 3595.3887839066897, 3597.2805438912847, 3603.117236277129, 4808.35087263229, 5082.695038297714, 5097.108006098843, 5104.234364845154, 5112.897742045213, 4873.634477414137, 4942.975285123552, 4952.356193694796, 4953.529414705597, 5005.0, 4911.091448082117, 4931.901361972812, 4937.432195297587, 4946.307516947702, 4956.6530342877095, 4610.400647915883, 4776.498467660985, 4840.6127509798425, 4843.2250839865455, 4861.878453038702, 4654.348391225299, 4772.141014617402, 4944.554990050912, 4957.182064959241, 4964.081644895706, 4881.633877459134, 4896.583790377857, 4911.8280860169725, 4913.336699545515, 4913.452262537432], "value": 3767.426023555573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.5680608782983, 641.8812519683859, 759.096674956801, 773.566802590549, 781.2695130053404, 11340.262882912615, 11514.654560363191, 11564.479598418071, 11598.246114002604, 12057.577984770534, 11995.940020299908, 12063.577774777885, 12077.516899324039, 12091.516339346415, 12150.02799776018, 623.688155922039, 760.7147319755092, 761.1589193940699, 765.9885101723479, 769.0387016229713, 769.734441617641, 770.0066913681372, 770.118214644232, 773.3001633521644, 777.6733771815851, 816.2245866426889, 816.2653611749444, 816.2898278497715, 818.705266104202, 819.5328662662284, 663.0352836622702, 811.8011087283653, 814.0028465130198, 827.1108558299821, 841.8063845315551, 603.387561624951, 609.9725512351911, 617.7745123030062, 619.2321521313584, 619.6065498408498, 12333.62999110028, 12425.75148497025, 12442.315672638002, 12445.751084978341, 12467.563635272722, 11915.165938384316, 12340.444679989421, 12542.435590398454, 12781.297028663419, 12806.48774049037, 9888.703338899773, 9903.653372132012, 9949.403035817802, 10056.849147262797, 10098.242631802645, 3287.96712032879, 3307.8676852925855, 3326.0, 3355.362481128602, 3408.3353746019534, 41521.37717934234, 41611.1677766446, 41739.7913010436, 41939.1612167758, 42001.78999105016, 9614.278929080347, 9756.95121524402, 10057.0, 10066.09405153525, 10095.24285678577, 15868.20658967047, 15931.601709957113, 15946.840531594535, 16023.278952447168, 16026.519204423887, 6198.163247961557, 6276.623402595859, 6356.014817703263, 6435.0, 6540.247871494839, 3598.982005089958, 3606.1165014571075, 3624.9456258156147, 3715.8142092895246, 3717.925641487155, 2840.5171120909495, 2894.1028281232884, 2905.5060639691305, 2910.63617047869, 2912.796104272723, 476.7592365855221, 498.7755510020505, 505.36324231468615, 508.32646743065584, 510.8314256295488, 536.948989845964, 565.03346507517, 579.5537436174122, 582.5194214772829, 589.6874656432097, 7408.629568521553, 7410.555366678017, 7489.775306740807, 7666.923330766621, 7675.923240767521, 457.86721850662934, 505.3329604921468, 567.6508946997567, 584.899498233421, 593.2317648645015, 3427.8971630851115, 3511.964880351215, 3575.66031227033, 3583.6416358363954, 3589.569251689814, 50611.74694126506, 51101.488985110416, 52255.73872130615, 52459.0, 52640.47359526356, 45166.77416612962, 46823.0, 46885.53114468812, 47134.71883125897, 47433.28850067252, 42437.1512569753, 42902.0, 42984.0, 43316.78341608335, 43538.34692479552, 7429.294217049372, 7560.281773231534, 7584.355329796808, 7739.41954353437, 7739.729109481141, 28787.712122878504, 28902.132936011953, 29245.561316580694, 29851.701482984892, 29915.102546923627, 37498.62501375061, 37889.24221515499, 38115.80942095272, 39094.609053909095, 39103.2179356417, 9190.264778817813, 9502.382345147544, 9555.9044409555, 9648.903510964801, 9722.125008749246, 10548.0, 10795.460226988462, 10896.400697961371, 11092.833607495733, 11097.778044439228, 9391.20174785151, 9526.190273826525, 9604.759881002752, 9833.459159746282, 10329.793404131726, 10158.898411015794, 10293.228007899288, 10353.0, 10431.739206519898, 10481.42352170638, 9475.668351607661, 9521.19069879068, 9552.42685438876, 9620.37467564606, 9748.073932976356, 8598.183172598594, 8708.34687398435, 8808.163224493663, 8884.333674974274, 9158.267338612763, 8726.91273087261, 8750.299976001777, 8759.255463285692, 8903.421277616933, 8989.325800565115], "value": 5687.933725129051, "unit": "score"}], "name": "dromaeo_css", "value": 6067.689263401245, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 109.0, 114.0, 113.0, 113.0, 102.0, 113.0, 113.0, 114.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 135.0, 170.0, 203.0, 145.0, 167.0, 175.0, 134.0, 190.0, 134.0], "value": 162.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 161.0, 162.0, 162.0, 161.0, 162.0, 163.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 122.0, 118.0, 80.0, 78.0, 82.0, 125.0, 108.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 156.0, 93.0, 94.0, 94.0, 153.0, 93.0, 93.0, 143.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 97.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 94.0, 66.0, 67.0], "value": 71.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 81.0, 91.0, 82.0, 83.0, 82.0, 84.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 137.0, 134.0, 132.0, 133.0, 130.0, 130.0, 165.0, 133.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 174.0, 180.0, 177.0, 176.0, 174.0, 175.0, 173.0, 174.0, 179.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 74.0, 76.0, 74.0, 75.0, 74.0, 72.0, 73.0, 72.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1603.8999999999999, "alertThreshold": 2.0}]} 01:58:23 INFO - Return code: 0 01:58:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:58:23 ERROR - # TBPL SUCCESS # 01:58:23 INFO - Running post-action listener: _resource_record_post_action 01:58:23 INFO - Running post-run listener: _resource_record_post_run 01:58:24 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518926336; Read time: 404; Write time: 383768 01:58:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 234983424; Read time: 196; Write time: 194040 01:58:24 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283942912; Read time: 208; Write time: 189728 01:58:24 INFO - Running post-run listener: _upload_blobber_files 01:58:24 INFO - Blob upload gear active. 01:58:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:58:24 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 01:58:24 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'] 01:58:24 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 01:58:25 INFO - (blobuploader) - INFO - Open directory for files ... 01:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:58:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:25 INFO - (blobuploader) - INFO - Done attempting. 01:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:26 INFO - (blobuploader) - INFO - Done attempting. 01:58:26 INFO - (blobuploader) - INFO - Iteration through files over. 01:58:26 INFO - Return code: 0 01:58:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:58:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:58:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df4b5eca14ebc7169095c81d84d28449a4413c1bbeaef195a7d0dc2b47ced0ae20bbd76df3d63e5b84c9cc3807c85ae9c422f6d427393f1e76be86c26e1d68ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bac5b49580949f3d95505d88e4d046313ad7638fa5084201fcb3259d48c1490e426c50c9403ecf2c9f8d8284ecef92c91c519732db3e157d5a268556197af1b7"} 01:58:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:58:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:58:26 INFO - Contents: 01:58:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df4b5eca14ebc7169095c81d84d28449a4413c1bbeaef195a7d0dc2b47ced0ae20bbd76df3d63e5b84c9cc3807c85ae9c422f6d427393f1e76be86c26e1d68ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bac5b49580949f3d95505d88e4d046313ad7638fa5084201fcb3259d48c1490e426c50c9403ecf2c9f8d8284ecef92c91c519732db3e157d5a268556197af1b7"} 01:58:26 INFO - Running post-run listener: copy_logs_to_upload_dir 01:58:26 INFO - Copying logs to upload dir... 01:58:26 INFO - mkdir: /builds/slave/test/build/upload/logs 01:58:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.565932 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-01 01:58:26.475881) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 01:58:26.479407) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091 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/df4b5eca14ebc7169095c81d84d28449a4413c1bbeaef195a7d0dc2b47ced0ae20bbd76df3d63e5b84c9cc3807c85ae9c422f6d427393f1e76be86c26e1d68ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bac5b49580949f3d95505d88e4d046313ad7638fa5084201fcb3259d48c1490e426c50c9403ecf2c9f8d8284ecef92c91c519732db3e157d5a268556197af1b7"} build_url:https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/bjVRBxphRGeTip82n_QhHQ/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/df4b5eca14ebc7169095c81d84d28449a4413c1bbeaef195a7d0dc2b47ced0ae20bbd76df3d63e5b84c9cc3807c85ae9c422f6d427393f1e76be86c26e1d68ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bac5b49580949f3d95505d88e4d046313ad7638fa5084201fcb3259d48c1490e426c50c9403ecf2c9f8d8284ecef92c91c519732db3e157d5a268556197af1b7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 01:58:26.503598) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 01:58:26.503910) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462068079.355473-316063091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 01:58:26.585791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 01:58:26.586113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 01:58:26.586393) ========= ========= Total master_lag: 0.22 =========