builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1463097633.25 results: success (0) buildid: 20160512153644 builduid: 424643868e5e4cccaab4ab7df362a044 revision: 30601f36e8518c2ee5c65de4a13d10d69d748530 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.246363) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.246847) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.247119) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.255940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.256228) ========= 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=62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 17:00: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 11.1M=0.001s 2016-05-12 17:00:33 (11.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.365450) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.365763) ========= 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=62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009616 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.413345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.413705) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 30601f36e8518c2ee5c65de4a13d10d69d748530 --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 30601f36e8518c2ee5c65de4a13d10d69d748530 --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=62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 17:00:33,586 truncating revision to first 12 chars 2016-05-12 17:00:33,586 Setting DEBUG logging. 2016-05-12 17:00:33,586 attempt 1/10 2016-05-12 17:00:33,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/30601f36e851?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 17:00:33,833 unpacking tar archive at: fx-team-30601f36e851/testing/mozharness/ program finished with exit code 0 elapsedTime=0.490711 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.914792) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.915342) ========= script_repo_revision: 30601f36e8518c2ee5c65de4a13d10d69d748530 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.915974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.916408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 17:00:33.923461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-12 17:00:33.923808) ========= /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=62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:00:34 INFO - MultiFileLogger online at 20160512 17:00:34 in /builds/slave/test 17:00: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 17:00:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:00:34 INFO - {'append_to_log': False, 17:00:34 INFO - 'base_work_dir': '/builds/slave/test', 17:00:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:00:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:00:34 INFO - 'branch': 'Fx-Team-Non-PGO', 17:00:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:00:34 INFO - 'config_files': ('talos/linux_config.py',), 17:00:34 INFO - 'default_actions': ('clobber', 17:00:34 INFO - 'read-buildbot-config', 17:00:34 INFO - 'download-and-extract', 17:00:34 INFO - 'populate-webroot', 17:00:34 INFO - 'create-virtualenv', 17:00:34 INFO - 'install', 17:00:34 INFO - 'run-tests'), 17:00:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:00:34 INFO - 'download_minidump_stackwalk': True, 17:00:34 INFO - 'download_symbols': 'ondemand', 17:00:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:00:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:00:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:00:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:00:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:00:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:00:34 INFO - 'installer_path': 'installer.exe', 17:00:34 INFO - 'log_level': 'info', 17:00:34 INFO - 'log_name': 'talos', 17:00:34 INFO - 'log_to_console': True, 17:00:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:00:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:00:34 INFO - 'opt_config_files': (), 17:00:34 INFO - 'pip_index': False, 17:00:34 INFO - 'sps_profile': False, 17:00:34 INFO - 'sps_profile_interval': 0, 17:00:34 INFO - 'suite': 'dromaeojs', 17:00:34 INFO - 'system_bits': '32', 17:00:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:00:34 INFO - 'title': 'talos-linux64-ix-018', 17:00:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:00:34 INFO - 'use_talos_json': True, 17:00:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:00:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:00:34 INFO - 'work_dir': 'build'} 17:00:34 INFO - ##### 17:00:34 INFO - ##### Running clobber step. 17:00:34 INFO - ##### 17:00:34 INFO - Running pre-action listener: _resource_record_pre_action 17:00:34 INFO - Running main action method: clobber 17:00:34 INFO - rmtree: /builds/slave/test/build 17:00:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:00:34 INFO - Running post-action listener: _resource_record_post_action 17:00:34 INFO - ##### 17:00:34 INFO - ##### Finished clobber step (success) 17:00:34 INFO - ##### 17:00:34 INFO - ##### 17:00:34 INFO - ##### Running read-buildbot-config step. 17:00:34 INFO - ##### 17:00:34 INFO - Running pre-action listener: _resource_record_pre_action 17:00:34 INFO - Running main action method: read_buildbot_config 17:00:34 INFO - Using buildbot properties: 17:00:34 INFO - { 17:00:34 INFO - "project": "", 17:00:34 INFO - "product": "firefox", 17:00:34 INFO - "script_repo_revision": "production", 17:00:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:00:34 INFO - "repository": "", 17:00:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:00:34 INFO - "buildid": "20160512153644", 17:00:34 INFO - "pgo_build": "False", 17:00:34 INFO - "basedir": "/builds/slave/test", 17:00:34 INFO - "buildnumber": 1678, 17:00:34 INFO - "slavename": "talos-linux64-ix-018", 17:00:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:00:34 INFO - "platform": "ubuntu64_hw", 17:00:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:00:34 INFO - "branch": "fx-team", 17:00:34 INFO - "repo_path": "integration/fx-team", 17:00:34 INFO - "revision": "30601f36e8518c2ee5c65de4a13d10d69d748530", 17:00:34 INFO - "stage_platform": "linux64", 17:00:34 INFO - "builduid": "424643868e5e4cccaab4ab7df362a044", 17:00:34 INFO - "slavebuilddir": "test" 17:00:34 INFO - } 17:00:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:00:34 INFO - Running post-action listener: _resource_record_post_action 17:00:34 INFO - ##### 17:00:34 INFO - ##### Finished read-buildbot-config step (success) 17:00:34 INFO - ##### 17:00:34 INFO - ##### 17:00:34 INFO - ##### Running download-and-extract step. 17:00:34 INFO - ##### 17:00:34 INFO - Running pre-action listener: _resource_record_pre_action 17:00:34 INFO - Running main action method: download_and_extract 17:00:34 INFO - mkdir: /builds/slave/test/build/tests 17:00: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')]} 17:00:34 INFO - https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:35 INFO - Downloaded 1361 bytes. 17:00:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:00:35 INFO - Using the following test package requirements: 17:00:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:00:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:00:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:00:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:35 INFO - u'jsshell-linux-x86_64.zip'], 17:00:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:00:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:00:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:00:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:00:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:00:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:00:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:35 INFO - https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:36 INFO - Downloaded 22329650 bytes. 17:00:36 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'] 17:00:36 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 17:00:37 INFO - Return code: 0 17:00:37 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 17:00:37 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')]} 17:00:37 INFO - https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:00:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:00:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:00:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:39 INFO - Downloaded 22329650 bytes. 17:00:39 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'] 17:00:39 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 17:00:40 INFO - Return code: 0 17:00:40 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')]} 17:00:40 INFO - https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:41 INFO - Downloaded 10840239 bytes. 17:00:41 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'] 17:00:41 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 17:00:41 INFO - Return code: 0 17:00: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')]} 17:00:41 INFO - https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:00:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:00:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:00:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzrobNLTT_mCF9KEzf2AmA/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 17:00:43 INFO - Downloaded 54695636 bytes. 17:00:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:00:43 INFO - mkdir: /builds/slave/test/properties 17:00:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:00:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:00:43 INFO - Contents: 17:00:43 INFO - build_url:https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:00:43 INFO - Running post-action listener: _resource_record_post_action 17:00:43 INFO - Running post-action listener: set_extra_try_arguments 17:00:43 INFO - ##### 17:00:43 INFO - ##### Finished download-and-extract step (success) 17:00:43 INFO - ##### 17:00:43 INFO - ##### 17:00:43 INFO - ##### Running populate-webroot step. 17:00:43 INFO - ##### 17:00:43 INFO - Running pre-action listener: _resource_record_pre_action 17:00:43 INFO - Running main action method: populate_webroot 17:00:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:00:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:00:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:00:43 INFO - '--tppagecycles', 17:00:43 INFO - '7'], 17:00:43 INFO - 'tests': ['tsvgm']}}, 17:00:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:00:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:00:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:00:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:00:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:43 INFO - 'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:43 INFO - 'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['damp', 'tps']}, 17:00:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:43 INFO - 'tests': ['damp', 'tps']}, 17:00:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['dromaeo_dom']}, 17:00:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:00:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['a11yr', 17:00:43 INFO - 'ts_paint', 17:00:43 INFO - 'tpaint', 17:00:43 INFO - 'sessionrestore', 17:00:43 INFO - 'sessionrestore_no_auto_restore', 17:00:43 INFO - 'tabpaint']}, 17:00:43 INFO - 'other-e10s': {'tests': ['a11yr', 17:00:43 INFO - 'ts_paint', 17:00:43 INFO - 'tpaint', 17:00:43 INFO - 'sessionrestore', 17:00:43 INFO - 'sessionrestore_no_auto_restore', 17:00:43 INFO - 'tabpaint']}, 17:00:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:00:43 INFO - 'ts_paint', 17:00:43 INFO - 'tpaint', 17:00:43 INFO - 'sessionrestore', 17:00:43 INFO - 'sessionrestore_no_auto_restore', 17:00:43 INFO - 'tabpaint']}, 17:00:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:00:43 INFO - 'ts_paint', 17:00:43 INFO - 'tpaint', 17:00:43 INFO - 'sessionrestore', 17:00:43 INFO - 'sessionrestore_no_auto_restore', 17:00:43 INFO - 'tabpaint']}, 17:00:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['a11yr', 17:00:43 INFO - 'ts_paint', 17:00:43 INFO - 'tpaint', 17:00:43 INFO - 'sessionrestore', 17:00:43 INFO - 'sessionrestore_no_auto_restore', 17:00:43 INFO - 'tabpaint']}, 17:00:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['a11yr', 17:00:43 INFO - 'ts_paint', 17:00:43 INFO - 'tpaint', 17:00:43 INFO - 'sessionrestore', 17:00:43 INFO - 'sessionrestore_no_auto_restore', 17:00:43 INFO - 'tabpaint']}, 17:00:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['tsvgx', 17:00:43 INFO - 'tsvgr_opacity', 17:00:43 INFO - 'tart', 17:00:43 INFO - 'tscrollx', 17:00:43 INFO - 'cart']}, 17:00:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:00:43 INFO - 'tsvgr_opacity', 17:00:43 INFO - 'tart', 17:00:43 INFO - 'tscrollx', 17:00:43 INFO - 'cart']}, 17:00:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:43 INFO - 'talos_options': ['--disable-e10s'], 17:00:43 INFO - 'tests': ['tp5o']}, 17:00:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:43 INFO - 'tests': ['tp5o']}, 17:00:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:43 INFO - 'talos_options': ['--disable-e10s', 17:00:43 INFO - '--xperf_path', 17:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:43 INFO - 'tests': ['tp5n']}, 17:00:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:43 INFO - 'talos_options': ['--xperf_path', 17:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:43 INFO - 'tests': ['tp5n']}}, 17:00:43 INFO - 'talos.zip': {'path': '', 17:00:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:00:43 INFO - Running post-action listener: _resource_record_post_action 17:00:43 INFO - ##### 17:00:43 INFO - ##### Finished populate-webroot step (success) 17:00:43 INFO - ##### 17:00:43 INFO - ##### 17:00:43 INFO - ##### Running create-virtualenv step. 17:00:43 INFO - ##### 17:00:43 INFO - Running pre-action listener: _resource_record_pre_action 17:00:43 INFO - Running main action method: create_virtualenv 17:00:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:00:43 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 17:00:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:00:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:00:44 INFO - Using real prefix '/usr' 17:00:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:00:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:00:46 INFO - Installing pip.................done. 17:00:46 INFO - Return code: 0 17:00:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:46 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 0x7f524d5f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', '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 17:00:46 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 17:00:46 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 17:00:46 INFO - Using env: {'DISPLAY': ':0', 17:00:46 INFO - 'HOME': '/home/cltbld', 17:00:46 INFO - 'LANG': 'en_US.UTF-8', 17:00:46 INFO - 'LANGUAGE': 'en_US:en', 17:00:46 INFO - 'LOGNAME': 'cltbld', 17:00:46 INFO - 'MAIL': '/var/mail/cltbld', 17:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:46 INFO - 'MOZ_NO_REMOTE': '1', 17:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:46 INFO - 'NO_EM_RESTART': '1', 17:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:46 INFO - 'PWD': '/builds/slave/test', 17:00:46 INFO - 'SHELL': '/bin/bash', 17:00:46 INFO - 'SHLVL': '1', 17:00:46 INFO - 'TERM': 'linux', 17:00:46 INFO - 'TMOUT': '86400', 17:00:46 INFO - 'USER': 'cltbld', 17:00:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:46 INFO - '_': '/tools/buildbot/bin/python'} 17:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:46 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 17:00:46 INFO - Cleaning up... 17:00:46 INFO - Return code: 0 17:00:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:46 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 0x7f524d5f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', '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 17:00:46 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 17:00:46 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 17:00:46 INFO - Using env: {'DISPLAY': ':0', 17:00:46 INFO - 'HOME': '/home/cltbld', 17:00:46 INFO - 'LANG': 'en_US.UTF-8', 17:00:46 INFO - 'LANGUAGE': 'en_US:en', 17:00:46 INFO - 'LOGNAME': 'cltbld', 17:00:46 INFO - 'MAIL': '/var/mail/cltbld', 17:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:46 INFO - 'MOZ_NO_REMOTE': '1', 17:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:46 INFO - 'NO_EM_RESTART': '1', 17:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:46 INFO - 'PWD': '/builds/slave/test', 17:00:46 INFO - 'SHELL': '/bin/bash', 17:00:46 INFO - 'SHLVL': '1', 17:00:46 INFO - 'TERM': 'linux', 17:00:46 INFO - 'TMOUT': '86400', 17:00:46 INFO - 'USER': 'cltbld', 17:00:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:46 INFO - '_': '/tools/buildbot/bin/python'} 17:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:47 INFO - Downloading/unpacking psutil>=0.7.1 17:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:48 INFO - Installing collected packages: psutil 17:00:48 INFO - Running setup.py install for psutil 17:00:49 INFO - building 'psutil._psutil_linux' extension 17:00:49 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 17:00:49 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 17:00:49 INFO - building 'psutil._psutil_posix' extension 17:00:49 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 17:00:49 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 17:00:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:49 INFO - Successfully installed psutil 17:00:49 INFO - Cleaning up... 17:00:49 INFO - Return code: 0 17:00:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:00:49 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')]} 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:49 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')]} 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:49 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 0x7f524d5f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', '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 17:00:49 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 17:00:49 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 17:00:49 INFO - Using env: {'DISPLAY': ':0', 17:00:49 INFO - 'HOME': '/home/cltbld', 17:00:49 INFO - 'LANG': 'en_US.UTF-8', 17:00:49 INFO - 'LANGUAGE': 'en_US:en', 17:00:49 INFO - 'LOGNAME': 'cltbld', 17:00:49 INFO - 'MAIL': '/var/mail/cltbld', 17:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:49 INFO - 'MOZ_NO_REMOTE': '1', 17:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:49 INFO - 'NO_EM_RESTART': '1', 17:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:49 INFO - 'PWD': '/builds/slave/test', 17:00:49 INFO - 'SHELL': '/bin/bash', 17:00:49 INFO - 'SHLVL': '1', 17:00:49 INFO - 'TERM': 'linux', 17:00:49 INFO - 'TMOUT': '86400', 17:00:49 INFO - 'USER': 'cltbld', 17:00:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:49 INFO - '_': '/tools/buildbot/bin/python'} 17:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:00:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:00:51 INFO - Installing collected packages: mozsystemmonitor 17:00:51 INFO - Running setup.py install for mozsystemmonitor 17:00:51 INFO - Successfully installed mozsystemmonitor 17:00:51 INFO - Cleaning up... 17:00:51 INFO - Return code: 0 17:00:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:51 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 0x7f524d5f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', '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 17:00:51 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 17:00:51 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 17:00:51 INFO - Using env: {'DISPLAY': ':0', 17:00:51 INFO - 'HOME': '/home/cltbld', 17:00:51 INFO - 'LANG': 'en_US.UTF-8', 17:00:51 INFO - 'LANGUAGE': 'en_US:en', 17:00:51 INFO - 'LOGNAME': 'cltbld', 17:00:51 INFO - 'MAIL': '/var/mail/cltbld', 17:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:51 INFO - 'MOZ_NO_REMOTE': '1', 17:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:51 INFO - 'NO_EM_RESTART': '1', 17:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:51 INFO - 'PWD': '/builds/slave/test', 17:00:51 INFO - 'SHELL': '/bin/bash', 17:00:51 INFO - 'SHLVL': '1', 17:00:51 INFO - 'TERM': 'linux', 17:00:51 INFO - 'TMOUT': '86400', 17:00:51 INFO - 'USER': 'cltbld', 17:00:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:51 INFO - '_': '/tools/buildbot/bin/python'} 17:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:51 INFO - Downloading/unpacking blobuploader==1.2.4 17:00:51 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 17:00:51 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 17:00:51 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 17:00:51 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 17:00:51 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 17:00:51 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 17:00:53 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00:53 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 17:00:53 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 17:00:53 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 17:00:53 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 17:00:53 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 17:00:53 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 17:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:00:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00:54 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 17:00:54 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 17:00:54 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 17:00:54 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 17:00:54 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 17:00:54 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 17:00:54 INFO - Downloading docopt-0.6.1.tar.gz 17:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:54 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:54 INFO - Running setup.py install for blobuploader 17:00:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:00:54 INFO - Running setup.py install for requests 17:00:54 INFO - Running setup.py install for docopt 17:00:54 INFO - Successfully installed blobuploader requests docopt 17:00:54 INFO - Cleaning up... 17:00:54 INFO - Return code: 0 17:00:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:54 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 0x7f524d5f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', '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 17:00:54 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 17:00:54 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 17:00:54 INFO - Using env: {'DISPLAY': ':0', 17:00:54 INFO - 'HOME': '/home/cltbld', 17:00:54 INFO - 'LANG': 'en_US.UTF-8', 17:00:54 INFO - 'LANGUAGE': 'en_US:en', 17:00:54 INFO - 'LOGNAME': 'cltbld', 17:00:54 INFO - 'MAIL': '/var/mail/cltbld', 17:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:54 INFO - 'MOZ_NO_REMOTE': '1', 17:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:54 INFO - 'NO_EM_RESTART': '1', 17:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:54 INFO - 'PWD': '/builds/slave/test', 17:00:54 INFO - 'SHELL': '/bin/bash', 17:00:54 INFO - 'SHLVL': '1', 17:00:54 INFO - 'TERM': 'linux', 17:00:54 INFO - 'TMOUT': '86400', 17:00:54 INFO - 'USER': 'cltbld', 17:00:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:54 INFO - '_': '/tools/buildbot/bin/python'} 17:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:55 INFO - Running setup.py (path:/tmp/pip-OJ4Od0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:55 INFO - Running setup.py (path:/tmp/pip-Y5qjNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:55 INFO - Running setup.py (path:/tmp/pip-sHnZUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:55 INFO - Running setup.py (path:/tmp/pip-ERQJlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:55 INFO - Running setup.py (path:/tmp/pip-jfuJn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:55 INFO - Running setup.py (path:/tmp/pip-HLUqOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:55 INFO - Running setup.py (path:/tmp/pip-MeFQvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:55 INFO - Running setup.py (path:/tmp/pip-LSH8od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:55 INFO - Running setup.py (path:/tmp/pip-8p41O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:55 INFO - Running setup.py (path:/tmp/pip-sX47Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:55 INFO - Running setup.py (path:/tmp/pip-pwRPBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:55 INFO - Running setup.py (path:/tmp/pip-WPRlxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:55 INFO - Running setup.py (path:/tmp/pip-4Iht6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:55 INFO - Running setup.py (path:/tmp/pip-3WM9GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:55 INFO - Running setup.py (path:/tmp/pip-KQbkjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:55 INFO - Running setup.py (path:/tmp/pip-vxsg5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:56 INFO - Running setup.py (path:/tmp/pip-mkIUen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:56 INFO - Running setup.py install for manifestparser 17:00:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:00:56 INFO - Running setup.py install for mozcrash 17:00:56 INFO - Running setup.py install for mozdebug 17:00:56 INFO - Running setup.py install for mozdevice 17:00:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:00:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:00:56 INFO - Running setup.py install for mozfile 17:00:56 INFO - Running setup.py install for mozhttpd 17:00:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:00:56 INFO - Running setup.py install for mozinfo 17:00:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:00:56 INFO - Running setup.py install for mozInstall 17:00:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:00:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:00:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:00:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:00:56 INFO - Running setup.py install for mozleak 17:00:56 INFO - Running setup.py install for mozlog 17:00:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:00:57 INFO - Running setup.py install for moznetwork 17:00:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:00:57 INFO - Running setup.py install for mozprocess 17:00:57 INFO - Running setup.py install for mozprofile 17:00:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:00:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:00:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:00:57 INFO - Running setup.py install for mozrunner 17:00:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:00:57 INFO - Running setup.py install for mozscreenshot 17:00:57 INFO - Running setup.py install for moztest 17:00:57 INFO - Running setup.py install for mozversion 17:00:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:00:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:57 INFO - Cleaning up... 17:00:57 INFO - Return code: 0 17:00:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:57 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 0x7f524d5f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', '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 17:00:57 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 17:00:57 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 17:00:57 INFO - Using env: {'DISPLAY': ':0', 17:00:57 INFO - 'HOME': '/home/cltbld', 17:00:57 INFO - 'LANG': 'en_US.UTF-8', 17:00:57 INFO - 'LANGUAGE': 'en_US:en', 17:00:57 INFO - 'LOGNAME': 'cltbld', 17:00:57 INFO - 'MAIL': '/var/mail/cltbld', 17:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:57 INFO - 'MOZ_NO_REMOTE': '1', 17:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:57 INFO - 'NO_EM_RESTART': '1', 17:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:57 INFO - 'PWD': '/builds/slave/test', 17:00:57 INFO - 'SHELL': '/bin/bash', 17:00:57 INFO - 'SHLVL': '1', 17:00:57 INFO - 'TERM': 'linux', 17:00:57 INFO - 'TMOUT': '86400', 17:00:57 INFO - 'USER': 'cltbld', 17:00:57 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:57 INFO - '_': '/tools/buildbot/bin/python'} 17:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:57 INFO - Running setup.py (path:/tmp/pip-hiWbcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:57 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)) 17:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:57 INFO - Running setup.py (path:/tmp/pip-nbdUIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:58 INFO - Running setup.py (path:/tmp/pip-k1XOpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:58 INFO - Running setup.py (path:/tmp/pip-EG7uP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:58 INFO - Running setup.py (path:/tmp/pip-j05K1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:58 INFO - Running setup.py (path:/tmp/pip-hBhDe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:58 INFO - Running setup.py (path:/tmp/pip-m5gJXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:58 INFO - Running setup.py (path:/tmp/pip-4qKl9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:58 INFO - Running setup.py (path:/tmp/pip-LZwhR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:58 INFO - Running setup.py (path:/tmp/pip-PB0e_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:58 INFO - Running setup.py (path:/tmp/pip-1XB73l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:58 INFO - Running setup.py (path:/tmp/pip-JmJ6Ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:58 INFO - Running setup.py (path:/tmp/pip-MXjyJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:58 INFO - Running setup.py (path:/tmp/pip-YkSgU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:58 INFO - Running setup.py (path:/tmp/pip-LS5NPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:58 INFO - Running setup.py (path:/tmp/pip-ELWP6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:58 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)) 17:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:58 INFO - Running setup.py (path:/tmp/pip-j_fRte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:58 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)) 17:00:58 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)) 17:00:58 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)) 17:00:58 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)) 17:00:58 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)) 17:00:58 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)) 17:00:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:00 INFO - Downloading blessings-1.6.tar.gz 17:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:01:00 INFO - Installing collected packages: blessings 17:01:00 INFO - Running setup.py install for blessings 17:01:00 INFO - Successfully installed blessings 17:01:00 INFO - Cleaning up... 17:01:01 INFO - Return code: 0 17:01:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:01:01 INFO - Reading from file tmpfile_stdout 17:01:01 INFO - Current package versions: 17:01:01 INFO - argparse == 1.2.1 17:01:01 INFO - blessings == 1.6 17:01:01 INFO - blobuploader == 1.2.4 17:01:01 INFO - docopt == 0.6.1 17:01:01 INFO - manifestparser == 1.1 17:01:01 INFO - mozInstall == 1.12 17:01:01 INFO - mozcrash == 0.17 17:01:01 INFO - mozdebug == 0.1 17:01:01 INFO - mozdevice == 0.48 17:01:01 INFO - mozfile == 1.2 17:01:01 INFO - mozhttpd == 0.7 17:01:01 INFO - mozinfo == 0.9 17:01:01 INFO - mozleak == 0.1 17:01:01 INFO - mozlog == 3.2 17:01:01 INFO - moznetwork == 0.27 17:01:01 INFO - mozprocess == 0.22 17:01:01 INFO - mozprofile == 0.28 17:01:01 INFO - mozrunner == 6.11 17:01:01 INFO - mozscreenshot == 0.1 17:01:01 INFO - mozsystemmonitor == 0.0 17:01:01 INFO - moztest == 0.7 17:01:01 INFO - mozversion == 1.4 17:01:01 INFO - psutil == 3.1.1 17:01:01 INFO - requests == 1.2.3 17:01:01 INFO - wsgiref == 0.1.2 17:01:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:01 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 0x7f524d5f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', '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 17:01:01 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 17:01:01 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 17:01:01 INFO - Using env: {'DISPLAY': ':0', 17:01:01 INFO - 'HOME': '/home/cltbld', 17:01:01 INFO - 'LANG': 'en_US.UTF-8', 17:01:01 INFO - 'LANGUAGE': 'en_US:en', 17:01:01 INFO - 'LOGNAME': 'cltbld', 17:01:01 INFO - 'MAIL': '/var/mail/cltbld', 17:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:01 INFO - 'MOZ_NO_REMOTE': '1', 17:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:01 INFO - 'NO_EM_RESTART': '1', 17:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:01 INFO - 'PWD': '/builds/slave/test', 17:01:01 INFO - 'SHELL': '/bin/bash', 17:01:01 INFO - 'SHLVL': '1', 17:01:01 INFO - 'TERM': 'linux', 17:01:01 INFO - 'TMOUT': '86400', 17:01:01 INFO - 'USER': 'cltbld', 17:01:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:01 INFO - '_': '/tools/buildbot/bin/python'} 17:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:01 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)) 17:01:01 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)) 17:01:01 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)) 17:01:01 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)) 17:01:01 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)) 17:01:01 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)) 17:01:01 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)) 17:01:01 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)) 17:01:01 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)) 17:01:01 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)) 17:01:01 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)) 17:01:01 INFO - Cleaning up... 17:01:01 INFO - Return code: 0 17:01:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f524d5f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', '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 17:01:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:01:01 INFO - Using env: {'DISPLAY': ':0', 17:01:01 INFO - 'HOME': '/home/cltbld', 17:01:01 INFO - 'LANG': 'en_US.UTF-8', 17:01:01 INFO - 'LANGUAGE': 'en_US:en', 17:01:01 INFO - 'LOGNAME': 'cltbld', 17:01:01 INFO - 'MAIL': '/var/mail/cltbld', 17:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:01 INFO - 'MOZ_NO_REMOTE': '1', 17:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:01 INFO - 'NO_EM_RESTART': '1', 17:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:01 INFO - 'PWD': '/builds/slave/test', 17:01:01 INFO - 'SHELL': '/bin/bash', 17:01:01 INFO - 'SHLVL': '1', 17:01:01 INFO - 'TERM': 'linux', 17:01:01 INFO - 'TMOUT': '86400', 17:01:01 INFO - 'USER': 'cltbld', 17:01:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:01 INFO - '_': '/tools/buildbot/bin/python'} 17:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:01 INFO - Downloading/unpacking jsonschema 17:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:01:03 INFO - Downloading/unpacking functools32 (from jsonschema) 17:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:03 INFO - Downloading functools32-3.2.3-2.tar.gz 17:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:01:03 INFO - warning: no files found matching '*.txt' 17:01:03 INFO - no previously-included directories found matching 'build' 17:01:03 INFO - no previously-included directories found matching 'dist' 17:01:03 INFO - no previously-included directories found matching '.git*' 17:01:03 INFO - Installing collected packages: jsonschema, functools32 17:01:03 INFO - Running setup.py install for functools32 17:01:03 INFO - warning: no files found matching '*.txt' 17:01:03 INFO - no previously-included directories found matching 'build' 17:01:03 INFO - no previously-included directories found matching 'dist' 17:01:03 INFO - no previously-included directories found matching '.git*' 17:01:03 INFO - Successfully installed jsonschema functools32 17:01:03 INFO - Cleaning up... 17:01:03 INFO - Return code: 0 17:01:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:01: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')]} 17:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01: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')]} 17:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f524d5f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', '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 17:01: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', 'flake8'] in /builds/slave/test/build 17:01: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 flake8 17:01:03 INFO - Using env: {'DISPLAY': ':0', 17:01:03 INFO - 'HOME': '/home/cltbld', 17:01:03 INFO - 'LANG': 'en_US.UTF-8', 17:01:03 INFO - 'LANGUAGE': 'en_US:en', 17:01:03 INFO - 'LOGNAME': 'cltbld', 17:01:03 INFO - 'MAIL': '/var/mail/cltbld', 17:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:03 INFO - 'MOZ_NO_REMOTE': '1', 17:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:03 INFO - 'NO_EM_RESTART': '1', 17:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:03 INFO - 'PWD': '/builds/slave/test', 17:01:03 INFO - 'SHELL': '/bin/bash', 17:01:03 INFO - 'SHLVL': '1', 17:01:03 INFO - 'TERM': 'linux', 17:01:03 INFO - 'TMOUT': '86400', 17:01:03 INFO - 'USER': 'cltbld', 17:01:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:03 INFO - '_': '/tools/buildbot/bin/python'} 17:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:04 INFO - Downloading/unpacking flake8 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:01:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01: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 17:01:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:01:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:01:06 INFO - no previously-included directories found matching 'docs/_build' 17:01:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:01:06 INFO - Running setup.py install for pep8 17:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:01:06 INFO - no previously-included directories found matching 'docs/_build' 17:01:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:01:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:01:06 INFO - Cleaning up... 17:01:06 INFO - Return code: 0 17:01:06 INFO - Running post-action listener: _resource_record_post_action 17:01:06 INFO - Running post-action listener: _start_resource_monitoring 17:01:06 INFO - Starting resource monitoring. 17:01:06 INFO - ##### 17:01:06 INFO - ##### Finished create-virtualenv step (success) 17:01:06 INFO - ##### 17:01:06 INFO - ##### 17:01:06 INFO - ##### Running install step. 17:01:06 INFO - ##### 17:01:06 INFO - Running pre-action listener: _resource_record_pre_action 17:01:06 INFO - Running main action method: install 17:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:01:07 INFO - Reading from file tmpfile_stdout 17:01:07 INFO - Detecting whether we're running mozinstall >=1.0... 17:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:01:07 INFO - Reading from file tmpfile_stdout 17:01:07 INFO - Output received: 17:01:07 INFO - Usage: mozinstall [options] installer 17:01:07 INFO - Options: 17:01:07 INFO - -h, --help show this help message and exit 17:01:07 INFO - -d DEST, --destination=DEST 17:01:07 INFO - Directory to install application into. [default: 17:01:07 INFO - "/builds/slave/test"] 17:01:07 INFO - --app=APP Application being installed. [default: firefox] 17:01:07 INFO - mkdir: /builds/slave/test/build/application 17:01:07 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'] 17:01:07 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 17:01:23 INFO - Reading from file tmpfile_stdout 17:01:23 INFO - Output received: 17:01:23 INFO - /builds/slave/test/build/application/firefox/firefox 17:01:23 INFO - Running post-action listener: _resource_record_post_action 17:01:23 INFO - ##### 17:01:23 INFO - ##### Finished install step (success) 17:01:23 INFO - ##### 17:01:23 INFO - ##### 17:01:23 INFO - ##### Running run-tests step. 17:01:23 INFO - ##### 17:01:23 INFO - Running pre-action listener: _resource_record_pre_action 17:01:23 INFO - Running main action method: run_tests 17:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:01:23 INFO - Python 2.7.3 17:01:23 INFO - Return code: 0 17:01:23 INFO - grabbing minidump binary from tooltool 17:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:23 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a639c0>, '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 0x1a648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a64d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:01:23 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 17:01:23 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 17:01:23 INFO - Calling ['/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'] with output_timeout 600 17:01:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:01:23 INFO - Return code: 0 17:01:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:01:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:01:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:01:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:01:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:01:23 INFO - Return code: 0 17:01:23 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/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:01:23 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/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 17:01:23 INFO - Using env: {'DISPLAY': ':0', 17:01:23 INFO - 'HOME': '/home/cltbld', 17:01:23 INFO - 'LANG': 'en_US.UTF-8', 17:01:23 INFO - 'LANGUAGE': 'en_US:en', 17:01:23 INFO - 'LOGNAME': 'cltbld', 17:01:23 INFO - 'MAIL': '/var/mail/cltbld', 17:01:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:01:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:23 INFO - 'MOZ_NO_REMOTE': '1', 17:01:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:23 INFO - 'NO_EM_RESTART': '1', 17:01:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:23 INFO - 'PWD': '/builds/slave/test', 17:01:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:01:23 INFO - 'SHELL': '/bin/bash', 17:01:23 INFO - 'SHLVL': '1', 17:01:23 INFO - 'TERM': 'linux', 17:01:23 INFO - 'TMOUT': '86400', 17:01:23 INFO - 'USER': 'cltbld', 17:01:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713', 17:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:23 INFO - '_': '/tools/buildbot/bin/python'} 17:01:23 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/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:01:24 INFO - mozversion application_buildid: 20160512153644 17:01:24 INFO - mozversion application_changeset: 30601f36e8518c2ee5c65de4a13d10d69d748530 17:01:24 INFO - mozversion application_display_name: Nightly 17:01:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:01:24 INFO - mozversion application_name: Firefox 17:01:24 INFO - mozversion application_remotingname: firefox 17:01:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:01:24 INFO - mozversion application_vendor: Mozilla 17:01:24 INFO - mozversion application_version: 49.0a1 17:01:24 INFO - mozversion platform_buildid: 20160512153644 17:01:24 INFO - mozversion platform_changeset: 30601f36e8518c2ee5c65de4a13d10d69d748530 17:01:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:01:24 INFO - mozversion platform_version: 49.0a1 17:01:24 INFO - using testdate: 1463097684 17:01:24 INFO - actual date: 1463097684 17:01:24 INFO - starting webserver on 'localhost:52005' 17:01:24 INFO - SUITE-START | Running 2 tests 17:01:24 INFO - TEST-START | dromaeo_css 17:01:24 INFO - operating with platform_type : linux_ 17:01:24 INFO - Initialising browser for dromaeo_css test... 17:01:24 INFO - TEST-INFO | started process 31797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp29bD2O/profile http://localhost:52005/getInfo.html) 17:01:27 INFO - PROCESS | 31797 | __metrics Screen width/height:1600/1200 17:01:27 INFO - PROCESS | 31797 | colorDepth:24 17:01:27 INFO - PROCESS | 31797 | Browser inner width/height: 1024/697 17:01:27 INFO - PROCESS | 31797 | __metrics 17:01:28 ERROR - PROCESS | 31797 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:01:29 INFO - TEST-INFO | 31797: exit 0 17:01:29 INFO - Browser initialized. 17:01:29 INFO - Running cycle 1/1 for dromaeo_css test... 17:01:29 INFO - TEST-INFO | started process 31879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp29bD2O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:41 INFO - PROCESS | 31879 | RSS: Main: 153227264 17:01:41 INFO - PROCESS | 31879 | 17:02:32 INFO - PROCESS | 31879 | 1463097752459 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] 17:04:44 INFO - PROCESS | 31879 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52005/tests/dromaeo/cssquery-ext.html) 17:04:45 INFO - PROCESS | 31879 | RSS: Main: 235859968 17:04:45 INFO - PROCESS | 31879 | 17:07:47 INFO - PROCESS | 31879 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-ext.html (next: http://localhost:52005/tests/dromaeo/cssquery-jquery.html) 17:07:48 INFO - PROCESS | 31879 | RSS: Main: 237936640 17:07:48 INFO - PROCESS | 31879 | 17:10:50 INFO - PROCESS | 31879 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52005/tests/dromaeo/cssquery-mootools.html) 17:10:51 INFO - PROCESS | 31879 | RSS: Main: 244637696 17:10:51 INFO - PROCESS | 31879 | 17:13:53 INFO - PROCESS | 31879 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52005/tests/dromaeo/cssquery-prototype.html) 17:13:53 INFO - PROCESS | 31879 | RSS: Main: 234278912 17:13:53 INFO - PROCESS | 31879 | 17:16:56 INFO - PROCESS | 31879 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52005/tests/dromaeo/cssquery-yui.html) 17:16:56 INFO - PROCESS | 31879 | RSS: Main: 216358912 17:16:56 INFO - PROCESS | 31879 | 17:20:00 INFO - PROCESS | 31879 | Cycle 1(1): loaded http://localhost:52005/tests/dromaeo/cssquery-yui.html (next: http://localhost:52005/tests/dromaeo/cssquery-dojo.html) 17:20:00 INFO - PROCESS | 31879 | RSS: Main: 271904768 17:20:00 INFO - PROCESS | 31879 | 17:20:00 INFO - PROCESS | 31879 | __start_tp_report 17:20:00 INFO - PROCESS | 31879 | _x_x_mozilla_page_load 17:20:00 INFO - PROCESS | 31879 | _x_x_mozilla_page_load_details 17:20:00 INFO - PROCESS | 31879 | |i|pagename|runs| 17:20:00 INFO - PROCESS | 31879 | |0;dojo.html;2554.5529532331843;2580.690317161941;2593.7146913839474;2594.403287243934;2595.584706446968;4557.339185818063;4634.818121379044;4655;4714.929276060858;4718.410198725163;4663.2538793793;4668.06638672266;4683.32091846682;4711.623070154388;4727.9834835510355;4285.078708077763;4315.935260971088;4359.760213188273;4392.626626736731;4493.797779099932;4415.51429342772;4450.198964186445;4459.108178364324;4461.107778444308;4488.775561221943;4184.456020717318;4197.97901010496;4310.82756689732;4350.956490435118;4374.737515749065;4338.284183109783;4353.238183317907;4374.496932852699;4417.160739459492;4424.137293227822;4358.150160718661;4359.520452750195;4371.322445021026;4386.868393948154;4415.359772832921;4498.460184777848;4511.593956543927;4564.589186973189;4574.794134263966;4608.308753686973;4975.925361119586;4999.125153098194;5003.349564556621;5042.168042273057;5054.949450505522;5001.8499445016705;5005.499450055002;5012.824551140729;5041.6722913010535;5049.469805670426;4588.105319462706;4610.262358022734;4642.303654451859;4646;4717.693349932243;5072.644914855925;5079.9840031993745;5141.0232055909255;5146.588272938156;5160.458151894072;4798.688085274446;4890.682105663192;4901.044296362175;4910.508949105061;4918.114739346952;4929.088118698052;4977.576905962961;5015.6489045767175;5074.416442109205;5087.491250874883;4981.402231732215;5002.324686167393;5012.649114562018;5016.673916195436;5024.196128619476;4954.133026720309;4957.3555437793575;4959.479254678279;4984.053029924303;5001.7499125043605;4181.519125300569;4225.281702110648;4231.936520952188;4309.676774241944;4314.22343978087;3747.550293964687;3766.642168993941;3797.088698712289;3798.1074447504816;3801.847926082981;4288.699791014599;4331.220380331571;4334.068175342317;4337.175936572105;4386.649068074546;5099.847004589868;5120.539151476385;5127.2052831811125;5135.460776618476;5153.917677287812;4245.002424430257;4261.829526818955;4265.125649241898;4302.075053863435;4323.113761678848;4411.3824064630335;4490.2142125127975;4522.66080043998;4529.705569138061;4533.659975501851;4491.550844915482;4504.752238626841;4517.774111294357;4543.227651299287;4546.863594092182;5035.647504674637;5054.494550544916;5062.797488100582;5070.340855688737;5103.030424219386;4429.734215947054;4512.548745125461;4521.615662668579;4528.275475923836;4545.886352841206;4960.751962401793;4977.576905962889;4989.376327959005;4993.525615066563;5032.823851165192;4988.176950803077;5012.924806127984;5017.874553136201;5036.118679231046;5072.923906141485;4670.462896766915;4814.951850481591;4839.612830973584;4885.487023862585;4899.338589290543;4872.439669437918;4880.487548807324;4886.53577910098;4894.33926419943;4904.166291730343;4654.2785868190485;4785.952140478551;4786.353842231254;4875.87810304731;4888.291197776373;4857.295692124693;4917.655764096479;4926.926096108633;4939.357883475125;4946.925796112989;4793.113274044313;4836.927446088382;4854.271859221145;4858.5384388483035;4922.966177102705 17:20:00 INFO - PROCESS | 31879 | |1;ext.html;562.7017680629266;563.0849868962936;587.2131343999042;597.3459062326754;610.407904332797;39327.60672393275;40146.799266003705;40258.39612405813;40380.394294085614;40456.393154102676;40204.59795402045;40474;40699.79650101745;40827.59172408275;40887.59112408882;7317.926820731778;7518.097828260617;7658.693652253917;9992.100710936014;10187.032231937954;9949.30354875159;10048.74878128049;10077.54651040705;10079.949600252025;10106.343087699313;7425.517341372793;10064.547095380725;10113.190944724442;10149.64476243328;10153.746156346113;9871.654492092779;10187.235957303232;10225.284230103896;10471.528781204865;10503.632372866989;9957.103860652503;9992.350497217658;10082.747931301703;10083.092521673085;10092.646757363456;39581.60418395808;39615;39722;39866.40200396996;39893.60106398928;3266.395716792401;3287.704106630391;3395.7622966392364;3464.2725027744204;3477.3393055319407;29994.100176994725;30010.24974375658;30376;30658.38683226323;31565.684343156503;3522.964770352315;3523.700485458739;3553.662402071799;3556;3663.377225871608;242363;242930;243452;244202;245689;56455.15317270244;56577.71711141418;57325;57358.42641573615;57451;35383.64616353855;36396;36405.45391819125;38228;38439.423408648894;13248.668783280495;13258.801117983237;13273.800892986614;13287.468501260035;13329.466821327233;11841.703957401134;12062.51749929993;12063.914247717748;12080.456379462945;12092.455839487244;19409.767876694077;19512.950675513606;19586.31447899317;19617.31339403114;19678;6082.878342433127;7380.446466515033;7384.704611815468;7451.254874512505;7475.813104672427;829.4152622401193;890.1207524302022;925.0749250749251;931.7856892914667;951.7906060666643;27875.860620696767;28800.855995720307;29118.417631647673;29338.413231735245;29362.265943351158;988.8022395520925;990.3166814897842;1009.7627057641448;1045.9320144190756;1087.2660953856116;15278.31247593861;15293.847061529465;15485;15534.145621990672;15716.92141539285;363580;364496;366591;368432;368794;50400.49599504031;50811.23783143256;51245.74377128165;51354.74322628363;51435.48564514307;1163.8428812110426;1229.932353720554;1255.0837888341562;1285.6207418811473;1290.7224946636518;28524;29056.65848427458;29267.414651707273;29519.704802952554;29718.702812971595;43233;43718.78140609276;43819.56180438282;44024.55975440205;44273.77863110664;269462;272894;274176;275710;275967;23669.881650591637;25804.483910322066;26112.216633501026;26472.470550589267;28233.15300540987;42803.357949631405;43361.54245339472;43526.56473435225;43991.78004109959;44497.55502445064;36650.45024324691;37298.627013729514;37716.62283377131;38139;38371.80814095912;36445.45331820078;36836;37212.81393593015;37283.627163728015;37853.43219851649;36146.638533615376;36799.44800827936;36940.81529592335;36949.26101477902;37143.62856371402;31926.36147276995;33312.1671958203;33754;33806.32387352288;33906.66093339134;24612.261632151065;25435.236942891745;25459.599722015468;25486.87256563705;26054.60918086268 17:20:00 INFO - PROCESS | 31879 | |2;jquery.html;387.142479408111;389.108940526195;390.7616354024045;398.52177387135447;399.628345638556;15663.530094097181;17230.82769172308;17574.560635984108;17623.11884405781;17648.735268970944;16725.581860453494;17119.229634666437;17297;17506.299748010097;17510.474685759415;4838.51614838516;5034.244863270502;5260.763265653036;5340.412554619008;5386.515213630772;3720.1071742781673;4654.883627909296;6105.32841387447;6119.724612392453;6246.406591373812;6091.482224010964;6142.600730952474;6233.189685340899;6290.3709629037185;6297.118403423525;5974.253218347707;6035.788747393842;6191.94736894729;6216.844578885519;6225.844353891143;5294.867628309285;5392.4337944515655;5421.83734487966;5433.6196466247375;5469.179623056533;20948.37154885356;21108;21167.364979050653;21215.893920530452;21291;1999.7600287965392;2016.9697454538193;2164.6536554151417;2422.0917156066475;2566.961495577568;12926.612201633967;13155.856679607676;13427.731445371039;13742.312884355842;13747.656308592364;1748.3006797281062;1794.9820501795075;1813.610073834132;1816.727490876366;1818.8544916406656;63657;64744.3525564743;65804.67097664528;66919.33080669228;67261.66369168172;9667.951660241795;9793.608255669837;10144.442055687008;10158.746031349276;10233.539490722935;13747.656308592364;13801.930990344985;13803.930980345234;13846.238456884766;13849.16904985704;7679.116901556281;7683.116441609286;7701.075870895528;7747.806304842424;7809.882851757228;7362.3741981932135;7440.627968601549;7441.479096463196;7527.510711803715;7544.773656790305;6185.319614842364;6420.711068001951;6425.614463132227;6437.002264648987;6512.185976752906;1813.718873574598;1850.8704390692792;1850.9259629614664;1857;1888.225827410755;892.2727976698969;892.848215803315;982.8918818929913;992.5235886774389;1002.1832206751474;16729.498115056325;16997.815666221675;17019.14904254807;17138.228779704943;17318.220680069426;928.6563971330651;938.3619138985555;948.660437988007;949.4588084791602;967.2262190247915;8686.435381700168;9868.358556693793;10049.899501005042;10056.949715251523;10181.694549163536;312053;314830;317041;428384;446965;79651.20348796438;83647.5817620908;84572;85159.5742021286;85406.572967136;963.0946909904667;975.5756246032998;984.3552473130111;1001.6577785766962;1003.6437064841876;15608.141552214283;15886.364545418053;15937.36250549965;16033.35866565371;16367;35062.82468587641;36410.45384319184;36474.635253647124;36692.63307366892;36734.44898326474;49928.253946033314;51938;52538.737306313225;52732.47267527429;52810.94378112493;7480.551166930001;7750.0699916010435;7904.051513818378;7926.524408535506;8073.071596766212;8544.957275213585;11783.587574434854;11972.58095966637;12048.518059277882;12161.148719589544;9755.609775608897;10164.644237451654;10433.530491127765;10491.160707143257;10805.405702686114;6037;10133.493325333557;10347.793044139225;10364.637237696645;10365.326253793479;10316.17470602365;10363.84454233172;10594.15246780271;10660.413677247516;11008.34874768791;7781.455298129303;7833.960830195812;7905.802354941173;7948.165442628672;7948.920510794818;9970.700878973643;10186.134178594903;10231.079202871777;10243.948780256349;10247.282690211614 17:20:00 INFO - PROCESS | 31879 | |3;mootools.html;1300.3368282176086;1484.7030593881227;1525.6796072824704;1668.557832174473;1810.1492298619644;7316.670749816258;7763.417743669226;7789.844203115941;7952;7992.040955085398;7684.9615751921165;7846.136924938252;7850.568218747981;7859.410544209179;7870.212978702127;2141.4539292480395;2174.3803016140405;2174.521605246843;2181.378307182453;2181.901814418347;2211.4913569878936;2222.8777417242045;2239.261043855524;2267.399139228106;2272.068451934707;2150.1506904772605;2162.643163877958;2177.401214665964;2177.923772667957;2201.8128459081;2016.3850025742142;2019.2932473634257;2028.7058376535394;2034.5829105033433;2040.357287454447;2076.7092607034874;2109.0298462707174;2110.757262914754;2114.629939760551;2114.93655190343;7512.924870751277;7763.611819409007;7795;7845.843083138362;7846;4545.11370282795;4660.4174478190225;4674;4706.599939005188;4716.834910778106;2821.8024738268123;2831;2846.2599724071683;2854.0581608069288;2906.564015397686;922.2115091596722;923.1414784250644;923.9697737023238;966.5940305071816;986.4623780039824;10478.685639430752;10589.205809564237;10594.894051059468;10609.73475663107;10623.150147988143;3959;3984.362501999666;4046.069404037088;4085.632293093636;4111.259973204792;8381.329493640495;8432.114627964098;8459;8461.873071903927;8495.490270583785;4470.150671372428;4508.594226519629;4552.476465206478;4565.840195593139;4569.725816450957;3691.040329514292;4068.572799856032;4152.397902304149;4214.325707886724;4217.7891105445215;3344.2308269097757;3410.334984677964;3439.604445488801;3454.2227998700596;3463.653634636516;1003.5885287032281;1007.8488226765897;1009.8384258518602;1012.3875055591261;1019.0166489337824;792.9008873890764;854.0733304364834;915.3821170709745;920.5397301349325;924.1082355526949;5136.922946155811;5493.752781124859;5568.136938774496;5624.746886390122;5795.797147099831;888.2316795971439;921.3412410126791;947.8625599288065;953.9761505962267;991.7173605522391;3699.667029967316;3740.382836831947;3795.5065841440987;3813.656770890633;3893.766374017568;8698.521581313089;8901.465912045298;9031.36780425377;9152.496612686366;9168.312376571785;8912.331575131891;8994.50530220831;9011.63953441868;9147.72556823283;9159.267258619295;6952.2352541221435;7276.653819043494;7294.8905766413545;7358.816029599196;7490.962545187348;5544.584156188222;5653.491185793298;5820.592558520862;5832.066869301061;5917.526597872074;8413.789655258422;8950.14973577509;9064.274858011475;9142.222911052635;9185.035571265189;9081.863772043293;9218.492982885737;9280.535973201178;9301.023392543957;9392.953035235054;5922.851928701644;6669.7665581704405;6717.2946840581035;6779.966100169468;6834.2140653825445;7625.542467451749;7729.458937874295;7732.536047837148;7749.612519374122;7781.338586220235;6676.766313179015;6707.731690732316;6885.173779146535;6935.237123916264;7085.82285442868;6702.229243637044;6753.3246675332075;6770.221424536045;6801.761938332134;6830.692618832264;6381.3937675920715;6403.96798016007;6471.2234531856475;6479.157709497735;6494.772682956074;4818.373611430492;4845.079434907357;4845.466998630078;4938.629602779734;5010.398752149766;4685.882852928704;4742.88142796419;4743.952560474351;4804.711717296974;4819.084373968934 17:20:00 INFO - PROCESS | 31879 | |4;prototype.html;312.0980366740121;317.13106089315283;319.7234392250703;321.7667191286318;322.05798040730883;4634.745089020111;4662.370579971703;4692.554207350305;4701.9059618807605;4711.199096153654;4578.031446478013;4594.540545945404;4615.561521655437;4633;4635.096156249533;3451.430513965199;3574.1779390740144;3673.934558977893;3697.3899306614376;3701.1857391373856;3666.5233519642543;3681.7606855554436;3685.852565897361;3752.68102211311;3754.4180651998986;3479.2519608284215;3661.6085887362765;3680.613535578766;3698;3713.832877520518;3548.4322508398664;3622.800745958971;3666.816659167058;3667.7982710950887;3673.5040769496045;3249.5613092232484;3252.8373581321075;3259.445894197992;3282.1302354875975;3289.703926646613;4461.977690111561;4467;4478.4178056852725;4491.652504248745;4491.842785502492;3924.3132451820816;4157.438745769313;4157.605027522381;4174.977130603022;4196.17466402113;4841.7337046462435;4857.805687772485;4860.149473842063;4880.316755654211;4891.6820406673805;3542.875999340011;3556.822158892045;3561.821908904544;3564.9821750891338;3594.4967704521387;5003.199488081926;5074.071852695989;5120.180771076647;5138.10083235436;5168.173092305251;3589.138606734417;3589.838457269429;3597.6582224688614;3636.6726994570618;3644.507991421124;3634.6183650716293;3683.5211422515436;3686.944695829565;3691.5201023866725;3693.759905606127;4154.961259685078;4161.8959526012095;4163.7293575917465;4168.687348448879;4178.22702799983;4579.427571553556;4883.145449546315;4892.119418504703;4910.705357678551;4912.1158191525865;1252.2861968677767;1257.4972907375782;1269.1940617707821;1269.7714411406037;1270.5172034626967;805.959702014897;817.979550511242;855.2730179347504;877.8814859993819;879.9484615884085;4222.282212023963;4244.129953359554;4252.638525725348;4257.467816522934;4281.892952676208;4909.484504127086;4924.8030078797165;4939.481354457802;4942.975285123552;4948.703077815343;4106.733062350938;4194.832206711759;4235.385869048971;4242.151569686075;4255.319148936155;2718.768904643088;2730.3856632257584;2744.88832023027;2746.3546066674317;2757.076379412879;4567.634589232854;4581.358609794632;4606.6314694825005;4619.4687610925175;4619.544843374327;5067.883251800116;5145.562627176732;5152.763336799141;5163.070647283525;5230.555402790806;4459.108178364275;4476.820927162877;4481.932771008437;4551.726896386162;4561.794719237642;5000.974995125147;5012.3233363495465;5026.798928042837;5032.169692000925;5037.748112594282;4743.885186980988;4945.901081978268;4949.554540091409;4987.276844857548;5000.699958002531;4426.468823741172;4524.773761311987;4541.43232095988;4545.59089681917;4555.863324100283;3576.177479179751;3585.31878943;3597.4783656370205;3621.764585301947;3627.8186090695885;4864.27035944597;5000;5019.4863595482575;5023.844515761322;5031.647784655039;4884.584810291023;4909.214525675875;4911.533404326583;4919.3358896549935;4921.778519966681;4879.975600121977;4919.950800491949;4927.384076990376;4928.901421971469;4947.54047555979;4615.307703844316;4755.714657120584;4766.523347665206;4825.879353016203;4870.1233777920315;4885.633577481632;4921.803127874845;4942.456329803646;4949.133901567283;4949.935763810798;4803.687760295569;4820.927686084781;4835.492273311252;4859.514048595112;4891.241857512091 17:20:00 INFO - PROCESS | 31879 | |5;yui.html;709.2340272505693;735.0884902720626;749.0524486524544;767.3745897093868;810.8054067023916;13873.930630346847;14588.489402870888;14634.121952682834;14732.410703571872;15010.324535395906;14558.636034099127;14611.269436528157;14643.853561464382;14690.118592884408;14721.337539810707;682.4676752133319;823.0575990490885;863.7408777366796;872.2890843962182;875.8598624220094;841.5539763925129;845.1126317366771;851.1318455175717;852.8209076094028;855.4567849415604;887.2547060469204;900.0279697926223;902.1159263921361;904.2043002158125;904.5477261369315;708.3447810775039;878.0341624213378;898.7977705016384;899.1143723432414;905.5381755304776;665.3811954881958;665.9134312539387;669.3239827773934;669.4276393683427;669.7287598522606;12942.870571294261;12958.87041129586;12984.740305193844;12992.480300787956;13031.674208144777;11606.941965290203;11919;11926.642200733992;12045.63863084109;12262.754744905142;10998.230123891331;11034.227604067719;11271.211015228937;11279.492422840993;11961.521539138424;4166.208420400114;4229.259879521102;4265.53079161292;4394.934075988863;4405.31717583775;45213.547864521264;45280.77359613214;45375.092498149854;45423.545764542265;45634.77182614099;9823.017698230262;9861.309708320348;10316.587336506456;10399.376037437778;10768.784624307627;17350.39273625417;17581.824181758275;17717;17726.20232089559;17893.463196104138;7160.212376638566;7165.283471652897;7182.42540596751;7212.423006159494;7297.708091676273;3850.4994350734223;3936.232434675268;3980.7611543307494;4016.9957510622344;4070.7354021988476;2863.4559433707527;2944.175630823373;2947.4252520758673;2950;2951.9852400738287;521.9321488206584;544.7031367904501;545.7571380735535;550.0841099569252;561.332014902265;473.983410580628;530.3662123762067;534.2627174499244;536.7799202327027;603.101378945377;7711.273932400336;8045.758627241192;8105.230003149692;8106.554139522383;8170.591470426455;596.3648714119449;602.1148911100762;608.0301918440081;615.2524682510771;619.5121466145572;3756.492873462102;3769.246150769857;3816.713746469026;3863.0421332056053;3872.806359682061;50648.74675626598;51334.48665513372;51653.741731291855;52004.47995520072;52279.73860130675;46909.29636055462;47832.282515762294;47971;48292.5170748288;49431;41849.581504185175;42293.78853105715;42626;42695.57304426978;42888.57111428846;7591.58246296459;7719.150893401609;7775.339096176888;7815.14033456308;7986.881836543005;25636.23091307264;25968.740312596634;27109.322266943484;28813.135605931857;29363.85318073396;37875.621243788315;38110.42834357431;38387.04032399101;38536.42195367128;39180.608193917695;10650.307729997836;10856.402897840695;11602.88397116018;11647.835216478285;11654.184207105422;12055.51777928873;12329.50681972711;12331.568395106127;12645.873541264838;12943.417546210254;11624.535018599161;11847.585334513251;12146.331951742386;12389.75220495603;12390.752184956431;11513.53945842157;11742.70643233926;11923.284602923506;12270.938645306716;12502.624921252376;11105;11221.775564488502;11887.405629718307;11960.461779219782;11985.700357491132;9663.9033609663;9693.321467497208;9730.318877678494;9911.256655750703;10053.949730251303;9843;9946.552405141641;9968.202543796624;9990.600375984879;10095 17:20:00 INFO - PROCESS | 31879 | __end_tp_report 17:20:00 INFO - PROCESS | 31879 | __start_cc_report 17:20:00 INFO - PROCESS | 31879 | _x_x_mozilla_cycle_collect,843 17:20:00 INFO - PROCESS | 31879 | __end_cc_report 17:20:00 INFO - PROCESS | 31879 | __startTimestamp1463098800284__endTimestamp 17:20:00 INFO - PROCESS | 31879 | 17:20:00 INFO - PROCESS | 31879 | ------- Summary: start ------- 17:20:00 INFO - PROCESS | 31879 | Number of tests: 6 17:20:00 INFO - PROCESS | 31879 | 17:20:00 INFO - PROCESS | 31879 | [#0] dojo.html Cycles:165 Average:4627.01 Median:4711.62 stddev:485.05 (10.3%) stddev-sans-first:458.48 17:20:00 INFO - PROCESS | 31879 | Values: 2554.6 2580.7 2593.7 2594.4 2595.6 4557.3 4634.8 4655.0 4714.9 4718.4 4663.3 4668.1 4683.3 4711.6 4728.0 4285.1 4315.9 4359.8 4392.6 4493.8 4415.5 4450.2 4459.1 4461.1 4488.8 4184.5 4198.0 4310.8 4351.0 4374.7 4338.3 4353.2 4374.5 4417.2 4424.1 4358.2 4359.5 4371.3 4386.9 4415.4 4498.5 4511.6 4564.6 4574.8 4608.3 4975.9 4999.1 5003.3 5042.2 5054.9 5001.8 5005.5 5012.8 5041.7 5049.5 4588.1 4610.3 4642.3 4646.0 4717.7 5072.6 5080.0 5141.0 5146.6 5160.5 4798.7 4890.7 4901.0 4910.5 4918.1 4929.1 4977.6 5015.6 5074.4 5087.5 4981.4 5002.3 5012.6 5016.7 5024.2 4954.1 4957.4 4959.5 4984.1 5001.7 4181.5 4225.3 4231.9 4309.7 4314.2 3747.6 3766.6 3797.1 3798.1 3801.8 4288.7 4331.2 4334.1 4337.2 4386.6 5099.8 5120.5 5127.2 5135.5 5153.9 4245.0 4261.8 4265.1 4302.1 4323.1 4411.4 4490.2 4522.7 4529.7 4533.7 4491.6 4504.8 4517.8 4543.2 4546.9 5035.6 5054.5 5062.8 5070.3 5103.0 4429.7 4512.5 4521.6 4528.3 4545.9 4960.8 4977.6 4989.4 4993.5 5032.8 4988.2 5012.9 5017.9 5036.1 5072.9 4670.5 4815.0 4839.6 4885.5 4899.3 4872.4 4880.5 4886.5 4894.3 4904.2 4654.3 4786.0 4786.4 4875.9 4888.3 4857.3 4917.7 4926.9 4939.4 4946.9 4793.1 4836.9 4854.3 4858.5 4923.0 17:20:00 INFO - PROCESS | 31879 | 17:20:00 INFO - PROCESS | 31879 | [#1] ext.html Cycles:180 Average:45788.12 Median:19453.67 stddev:78328.85 (402.6%) stddev-sans-first:78474.98 17:20:00 INFO - PROCESS | 31879 | Values: 562.7 563.1 587.2 597.3 610.4 39327.6 40146.8 40258.4 40380.4 40456.4 40204.6 40474.0 40699.8 40827.6 40887.6 7317.9 7518.1 7658.7 9992.1 10187.0 9949.3 10048.7 10077.5 10079.9 10106.3 7425.5 10064.5 10113.2 10149.6 10153.7 9871.7 10187.2 10225.3 10471.5 10503.6 9957.1 9992.4 10082.7 10083.1 10092.6 39581.6 39615.0 39722.0 39866.4 39893.6 3266.4 3287.7 3395.8 3464.3 3477.3 29994.1 30010.2 30376.0 30658.4 31565.7 3523.0 3523.7 3553.7 3556.0 3663.4 242363.0 242930.0 243452.0 244202.0 245689.0 56455.2 56577.7 57325.0 57358.4 57451.0 35383.6 36396.0 36405.5 38228.0 38439.4 13248.7 13258.8 13273.8 13287.5 13329.5 11841.7 12062.5 12063.9 12080.5 12092.5 19409.8 19513.0 19586.3 19617.3 19678.0 6082.9 7380.4 7384.7 7451.3 7475.8 829.4 890.1 925.1 931.8 951.8 27875.9 28800.9 29118.4 29338.4 29362.3 988.8 990.3 1009.8 1045.9 1087.3 15278.3 15293.8 15485.0 15534.1 15716.9 363580.0 364496.0 366591.0 368432.0 368794.0 50400.5 50811.2 51245.7 51354.7 51435.5 1163.8 1229.9 1255.1 1285.6 1290.7 28524.0 29056.7 29267.4 29519.7 29718.7 43233.0 43718.8 43819.6 44024.6 44273.8 269462.0 272894.0 274176.0 275710.0 275967.0 23669.9 25804.5 26112.2 26472.5 28233.2 42803.4 43361.5 43526.6 43991.8 44497.6 36650.5 37298.6 37716.6 38139.0 38371.8 36445.5 36836.0 37212.8 37283.6 37853.4 36146.6 36799.4 36940.8 36949.3 37143.6 31926.4 33312.2 33754.0 33806.3 33906.7 24612.3 25435.2 25459.6 25486.9 26054.6 17:20:00 INFO - PROCESS | 31879 | 17:20:00 INFO - PROCESS | 31879 | [#2] jquery.html Cycles:180 Average:23988.39 Median:389.94 stddev:61143.45 (15680.4%) stddev-sans-first:61289.29 17:20:00 INFO - PROCESS | 31879 | Values: 387.1 389.1 390.8 398.5 399.6 15663.5 17230.8 17574.6 17623.1 17648.7 16725.6 17119.2 17297.0 17506.3 17510.5 4838.5 5034.2 5260.8 5340.4 5386.5 3720.1 4654.9 6105.3 6119.7 6246.4 6091.5 6142.6 6233.2 6290.4 6297.1 5974.3 6035.8 6191.9 6216.8 6225.8 5294.9 5392.4 5421.8 5433.6 5469.2 20948.4 21108.0 21167.4 21215.9 21291.0 1999.8 2017.0 2164.7 2422.1 2567.0 12926.6 13155.9 13427.7 13742.3 13747.7 1748.3 1795.0 1813.6 1816.7 1818.9 63657.0 64744.4 65804.7 66919.3 67261.7 9668.0 9793.6 10144.4 10158.7 10233.5 13747.7 13801.9 13803.9 13846.2 13849.2 7679.1 7683.1 7701.1 7747.8 7809.9 7362.4 7440.6 7441.5 7527.5 7544.8 6185.3 6420.7 6425.6 6437.0 6512.2 1813.7 1850.9 1850.9 1857.0 1888.2 892.3 892.8 982.9 992.5 1002.2 16729.5 16997.8 17019.1 17138.2 17318.2 928.7 938.4 948.7 949.5 967.2 8686.4 9868.4 10049.9 10056.9 10181.7 312053.0 314830.0 317041.0 428384.0 446965.0 79651.2 83647.6 84572.0 85159.6 85406.6 963.1 975.6 984.4 1001.7 1003.6 15608.1 15886.4 15937.4 16033.4 16367.0 35062.8 36410.5 36474.6 36692.6 36734.4 49928.3 51938.0 52538.7 52732.5 52810.9 7480.6 7750.1 7904.1 7926.5 8073.1 8545.0 11783.6 11972.6 12048.5 12161.1 9755.6 10164.6 10433.5 10491.2 10805.4 6037.0 10133.5 10347.8 10364.6 10365.3 10316.2 10363.8 10594.2 10660.4 11008.3 7781.5 7834.0 7905.8 7948.2 7948.9 9970.7 10186.1 10231.1 10243.9 10247.3 17:20:00 INFO - PROCESS | 31879 | 17:20:00 INFO - PROCESS | 31879 | [#3] mootools.html Cycles:180 Average:5128.06 Median:5724.64 stddev:2826.42 (49.4%) stddev-sans-first:2819.71 17:20:00 INFO - PROCESS | 31879 | Values: 1300.3 1484.7 1525.7 1668.6 1810.1 7316.7 7763.4 7789.8 7952.0 7992.0 7685.0 7846.1 7850.6 7859.4 7870.2 2141.5 2174.4 2174.5 2181.4 2181.9 2211.5 2222.9 2239.3 2267.4 2272.1 2150.2 2162.6 2177.4 2177.9 2201.8 2016.4 2019.3 2028.7 2034.6 2040.4 2076.7 2109.0 2110.8 2114.6 2114.9 7512.9 7763.6 7795.0 7845.8 7846.0 4545.1 4660.4 4674.0 4706.6 4716.8 2821.8 2831.0 2846.3 2854.1 2906.6 922.2 923.1 924.0 966.6 986.5 10478.7 10589.2 10594.9 10609.7 10623.2 3959.0 3984.4 4046.1 4085.6 4111.3 8381.3 8432.1 8459.0 8461.9 8495.5 4470.2 4508.6 4552.5 4565.8 4569.7 3691.0 4068.6 4152.4 4214.3 4217.8 3344.2 3410.3 3439.6 3454.2 3463.7 1003.6 1007.8 1009.8 1012.4 1019.0 792.9 854.1 915.4 920.5 924.1 5136.9 5493.8 5568.1 5624.7 5795.8 888.2 921.3 947.9 954.0 991.7 3699.7 3740.4 3795.5 3813.7 3893.8 8698.5 8901.5 9031.4 9152.5 9168.3 8912.3 8994.5 9011.6 9147.7 9159.3 6952.2 7276.7 7294.9 7358.8 7491.0 5544.6 5653.5 5820.6 5832.1 5917.5 8413.8 8950.1 9064.3 9142.2 9185.0 9081.9 9218.5 9280.5 9301.0 9393.0 5922.9 6669.8 6717.3 6780.0 6834.2 7625.5 7729.5 7732.5 7749.6 7781.3 6676.8 6707.7 6885.2 6935.2 7085.8 6702.2 6753.3 6770.2 6801.8 6830.7 6381.4 6404.0 6471.2 6479.2 6494.8 4818.4 4845.1 4845.5 4938.6 5010.4 4685.9 4742.9 4744.0 4804.7 4819.1 17:20:00 INFO - PROCESS | 31879 | 17:20:00 INFO - PROCESS | 31879 | [#4] prototype.html Cycles:180 Average:4050.94 Median:4543.51 stddev:1156.22 (25.4%) stddev-sans-first:1124.89 17:20:00 INFO - PROCESS | 31879 | Values: 312.1 317.1 319.7 321.8 322.1 4634.7 4662.4 4692.6 4701.9 4711.2 4578.0 4594.5 4615.6 4633.0 4635.1 3451.4 3574.2 3673.9 3697.4 3701.2 3666.5 3681.8 3685.9 3752.7 3754.4 3479.3 3661.6 3680.6 3698.0 3713.8 3548.4 3622.8 3666.8 3667.8 3673.5 3249.6 3252.8 3259.4 3282.1 3289.7 4462.0 4467.0 4478.4 4491.7 4491.8 3924.3 4157.4 4157.6 4175.0 4196.2 4841.7 4857.8 4860.1 4880.3 4891.7 3542.9 3556.8 3561.8 3565.0 3594.5 5003.2 5074.1 5120.2 5138.1 5168.2 3589.1 3589.8 3597.7 3636.7 3644.5 3634.6 3683.5 3686.9 3691.5 3693.8 4155.0 4161.9 4163.7 4168.7 4178.2 4579.4 4883.1 4892.1 4910.7 4912.1 1252.3 1257.5 1269.2 1269.8 1270.5 806.0 818.0 855.3 877.9 879.9 4222.3 4244.1 4252.6 4257.5 4281.9 4909.5 4924.8 4939.5 4943.0 4948.7 4106.7 4194.8 4235.4 4242.2 4255.3 2718.8 2730.4 2744.9 2746.4 2757.1 4567.6 4581.4 4606.6 4619.5 4619.5 5067.9 5145.6 5152.8 5163.1 5230.6 4459.1 4476.8 4481.9 4551.7 4561.8 5001.0 5012.3 5026.8 5032.2 5037.7 4743.9 4945.9 4949.6 4987.3 5000.7 4426.5 4524.8 4541.4 4545.6 4555.9 3576.2 3585.3 3597.5 3621.8 3627.8 4864.3 5000.0 5019.5 5023.8 5031.6 4884.6 4909.2 4911.5 4919.3 4921.8 4880.0 4920.0 4927.4 4928.9 4947.5 4615.3 4755.7 4766.5 4825.9 4870.1 4885.6 4921.8 4942.5 4949.1 4949.9 4803.7 4820.9 4835.5 4859.5 4891.2 17:20:00 INFO - PROCESS | 31879 | 17:20:00 INFO - PROCESS | 31879 | [#5] yui.html Cycles:180 Average:13068.16 Median:23480.55 stddev:14322.61 (61.0%) stddev-sans-first:14332.71 17:20:00 INFO - PROCESS | 31879 | Values: 709.2 735.1 749.1 767.4 810.8 13873.9 14588.5 14634.1 14732.4 15010.3 14558.6 14611.3 14643.9 14690.1 14721.3 682.5 823.1 863.7 872.3 875.9 841.6 845.1 851.1 852.8 855.5 887.3 900.0 902.1 904.2 904.5 708.3 878.0 898.8 899.1 905.5 665.4 665.9 669.3 669.4 669.7 12942.9 12958.9 12984.7 12992.5 13031.7 11606.9 11919.0 11926.6 12045.6 12262.8 10998.2 11034.2 11271.2 11279.5 11961.5 4166.2 4229.3 4265.5 4394.9 4405.3 45213.5 45280.8 45375.1 45423.5 45634.8 9823.0 9861.3 10316.6 10399.4 10768.8 17350.4 17581.8 17717.0 17726.2 17893.5 7160.2 7165.3 7182.4 7212.4 7297.7 3850.5 3936.2 3980.8 4017.0 4070.7 2863.5 2944.2 2947.4 2950.0 2952.0 521.9 544.7 545.8 550.1 561.3 474.0 530.4 534.3 536.8 603.1 7711.3 8045.8 8105.2 8106.6 8170.6 596.4 602.1 608.0 615.3 619.5 3756.5 3769.2 3816.7 3863.0 3872.8 50648.7 51334.5 51653.7 52004.5 52279.7 46909.3 47832.3 47971.0 48292.5 49431.0 41849.6 42293.8 42626.0 42695.6 42888.6 7591.6 7719.2 7775.3 7815.1 7986.9 25636.2 25968.7 27109.3 28813.1 29363.9 37875.6 38110.4 38387.0 38536.4 39180.6 10650.3 10856.4 11602.9 11647.8 11654.2 12055.5 12329.5 12331.6 12645.9 12943.4 11624.5 11847.6 12146.3 12389.8 12390.8 11513.5 11742.7 11923.3 12270.9 12502.6 11105.0 11221.8 11887.4 11960.5 11985.7 9663.9 9693.3 9730.3 9911.3 10053.9 9843.0 9946.6 9968.2 9990.6 10095.0 17:20:00 INFO - PROCESS | 31879 | -------- Summary: end -------- 17:20:00 INFO - PROCESS | 31879 | 17:20:00 INFO - TEST-INFO | 31879: exit 0 17:20:00 INFO - TEST-OK | dromaeo_css | took 1116684ms 17:20:00 INFO - TEST-START | kraken 17:20:00 INFO - operating with platform_type : linux_ 17:20:00 INFO - Initialising browser for kraken test... 17:20:00 INFO - TEST-INFO | started process 32058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp74WC_K/profile http://localhost:52005/getInfo.html) 17:20:04 INFO - PROCESS | 32058 | __metrics Screen width/height:1600/1200 17:20:04 INFO - PROCESS | 32058 | colorDepth:24 17:20:04 INFO - PROCESS | 32058 | Browser inner width/height: 1024/697 17:20:04 INFO - PROCESS | 32058 | __metrics 17:20:05 ERROR - PROCESS | 32058 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:20:06 INFO - TEST-INFO | 32058: exit 0 17:20:06 INFO - Browser initialized. 17:20:06 INFO - Running cycle 1/1 for kraken test... 17:20:06 INFO - TEST-INFO | started process 32137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp74WC_K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:17 INFO - PROCESS | 32137 | RSS: Main: 153722880 17:20:17 INFO - PROCESS | 32137 | 17:20:20 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52005/tests/kraken/driver.html?testName=audio-beat-detection) 17:20:21 INFO - PROCESS | 32137 | RSS: Main: 209154048 17:20:21 INFO - PROCESS | 32137 | 17:20:24 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52005/tests/kraken/driver.html?testName=audio-dft) 17:20:24 INFO - PROCESS | 32137 | RSS: Main: 196366336 17:20:24 INFO - PROCESS | 32137 | 17:20:28 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52005/tests/kraken/driver.html?testName=audio-fft) 17:20:28 INFO - PROCESS | 32137 | RSS: Main: 265981952 17:20:28 INFO - PROCESS | 32137 | 17:20:30 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52005/tests/kraken/driver.html?testName=audio-oscillator) 17:20:31 INFO - PROCESS | 32137 | RSS: Main: 174653440 17:20:31 INFO - PROCESS | 32137 | 17:20:33 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:20:34 INFO - PROCESS | 32137 | RSS: Main: 179392512 17:20:34 INFO - PROCESS | 32137 | 17:20:37 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52005/tests/kraken/driver.html?testName=imaging-darkroom) 17:20:38 INFO - PROCESS | 32137 | RSS: Main: 214589440 17:20:38 INFO - PROCESS | 32137 | 17:20:42 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52005/tests/kraken/driver.html?testName=imaging-desaturate) 17:20:42 INFO - PROCESS | 32137 | RSS: Main: 213401600 17:20:42 INFO - PROCESS | 32137 | 17:20:45 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52005/tests/kraken/driver.html?testName=json-parse-financial) 17:20:46 INFO - PROCESS | 32137 | RSS: Main: 213680128 17:20:46 INFO - PROCESS | 32137 | 17:20:48 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:20:48 INFO - PROCESS | 32137 | RSS: Main: 209444864 17:20:48 INFO - PROCESS | 32137 | 17:20:50 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:51 INFO - PROCESS | 32137 | RSS: Main: 207953920 17:20:51 INFO - PROCESS | 32137 | 17:20:53 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:54 INFO - PROCESS | 32137 | RSS: Main: 213164032 17:20:54 INFO - PROCESS | 32137 | 17:20:57 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:57 INFO - PROCESS | 32137 | RSS: Main: 218533888 17:20:57 INFO - PROCESS | 32137 | 17:21:00 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:21:01 INFO - PROCESS | 32137 | RSS: Main: 217018368 17:21:01 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | Cycle 1(1): loaded http://localhost:52005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52005/tests/kraken/driver.html?testName=ai-astar) 17:21:03 INFO - PROCESS | 32137 | RSS: Main: 264269824 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | __start_tp_report 17:21:03 INFO - PROCESS | 32137 | _x_x_mozilla_page_load 17:21:03 INFO - PROCESS | 32137 | _x_x_mozilla_page_load_details 17:21:03 INFO - PROCESS | 32137 | |i|pagename|runs| 17:21:03 INFO - PROCESS | 32137 | |0;ai-astar;122;110;116;116;115;116;115;117;115;115 17:21:03 INFO - PROCESS | 32137 | |1;audio-beat-detection;158;140;160;214;141;158;161;137;192;140 17:21:03 INFO - PROCESS | 32137 | |2;audio-dft;163;164;164;162;162;163;167;163;162;163 17:21:03 INFO - PROCESS | 32137 | |3;audio-fft;78;78;78;147;77;78;78;76;126;77 17:21:03 INFO - PROCESS | 32137 | |4;audio-oscillator;96;95;152;95;96;95;124;95;97;120 17:21:03 INFO - PROCESS | 32137 | |5;imaging-gaussian-blur;118;117;119;118;131;117;117;117;119;118 17:21:03 INFO - PROCESS | 32137 | |6;imaging-darkroom;148;148;148;148;149;148;148;148;150;149 17:21:03 INFO - PROCESS | 32137 | |7;imaging-desaturate;96;96;95;95;96;96;96;96;96;96 17:21:03 INFO - PROCESS | 32137 | |8;json-parse-financial;67;67;68;68;69;68;68;68;68;67 17:21:03 INFO - PROCESS | 32137 | |9;json-stringify-tinderbox;64;65;65;65;65;66;65;64;65;66 17:21:03 INFO - PROCESS | 32137 | |10;stanford-crypto-aes;92;86;86;86;86;92;88;87;147;87 17:21:03 INFO - PROCESS | 32137 | |11;stanford-crypto-ccm;141;142;141;140;139;139;139;142;156;157 17:21:03 INFO - PROCESS | 32137 | |12;stanford-crypto-pbkdf2;185;189;183;183;183;180;181;179;180;177 17:21:03 INFO - PROCESS | 32137 | |13;stanford-crypto-sha256-iterative;71;70;70;70;70;69;70;68;70;70 17:21:03 INFO - PROCESS | 32137 | __end_tp_report 17:21:03 INFO - PROCESS | 32137 | __start_cc_report 17:21:03 INFO - PROCESS | 32137 | _x_x_mozilla_cycle_collect,1951 17:21:03 INFO - PROCESS | 32137 | __end_cc_report 17:21:03 INFO - PROCESS | 32137 | __startTimestamp1463098863435__endTimestamp 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | ------- Summary: start ------- 17:21:03 INFO - PROCESS | 32137 | Number of tests: 14 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:2.91 (2.5%) stddev-sans-first:2.00 17:21:03 INFO - PROCESS | 32137 | Values: 122.0 110.0 116.0 116.0 115.0 116.0 115.0 117.0 115.0 115.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#1] audio-beat-detection Cycles:10 Average:160.10 Median:159.00 stddev:25.03 (15.7%) stddev-sans-first:26.54 17:21:03 INFO - PROCESS | 32137 | Values: 158.0 140.0 160.0 214.0 141.0 158.0 161.0 137.0 192.0 140.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 17:21:03 INFO - PROCESS | 32137 | Values: 163.0 164.0 164.0 162.0 162.0 163.0 167.0 163.0 162.0 163.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#3] audio-fft Cycles:10 Average:89.30 Median:78.00 stddev:25.37 (32.5%) stddev-sans-first:26.58 17:21:03 INFO - PROCESS | 32137 | Values: 78.0 78.0 78.0 147.0 77.0 78.0 78.0 76.0 126.0 77.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:95.00 stddev:19.43 (20.5%) stddev-sans-first:20.24 17:21:03 INFO - PROCESS | 32137 | Values: 96.0 95.0 152.0 95.0 96.0 95.0 124.0 95.0 97.0 120.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:118.00 stddev:4.25 (3.6%) stddev-sans-first:4.49 17:21:03 INFO - PROCESS | 32137 | Values: 118.0 117.0 119.0 118.0 131.0 117.0 117.0 117.0 119.0 118.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:21:03 INFO - PROCESS | 32137 | Values: 148.0 148.0 148.0 148.0 149.0 148.0 148.0 148.0 150.0 149.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:21:03 INFO - PROCESS | 32137 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 17:21:03 INFO - PROCESS | 32137 | Values: 67.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 67.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 17:21:03 INFO - PROCESS | 32137 | Values: 64.0 65.0 65.0 65.0 65.0 66.0 65.0 64.0 65.0 66.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#10] stanford-crypto-aes Cycles:10 Average:93.70 Median:87.00 stddev:18.87 (21.7%) stddev-sans-first:20.01 17:21:03 INFO - PROCESS | 32137 | Values: 92.0 86.0 86.0 86.0 86.0 92.0 88.0 87.0 147.0 87.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:141.50 stddev:6.90 (4.9%) stddev-sans-first:7.25 17:21:03 INFO - PROCESS | 32137 | Values: 141.0 142.0 141.0 140.0 139.0 139.0 139.0 142.0 156.0 157.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:183.00 stddev:3.40 (1.9%) stddev-sans-first:3.43 17:21:03 INFO - PROCESS | 32137 | Values: 185.0 189.0 183.0 183.0 183.0 180.0 181.0 179.0 180.0 177.0 17:21:03 INFO - PROCESS | 32137 | 17:21:03 INFO - PROCESS | 32137 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:0.79 (1.1%) stddev-sans-first:0.71 17:21:03 INFO - PROCESS | 32137 | Values: 71.0 70.0 70.0 70.0 70.0 69.0 70.0 68.0 70.0 70.0 17:21:03 INFO - PROCESS | 32137 | -------- Summary: end -------- 17:21:03 INFO - PROCESS | 32137 | 17:21:04 INFO - TEST-INFO | 32137: exit 0 17:21:04 INFO - TEST-OK | kraken | took 63464ms 17:21:04 INFO - SUITE-END | took 1180s 17:21:04 INFO - Completed test suite (00:19:40) 17:21:04 INFO - javascript benchmark 17:21:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2554.5529532331843, 2580.690317161941, 2593.7146913839474, 2594.403287243934, 2595.584706446968, 4557.339185818063, 4634.818121379044, 4655.0, 4714.929276060858, 4718.410198725163, 4663.2538793793, 4668.06638672266, 4683.32091846682, 4711.623070154388, 4727.9834835510355, 4285.078708077763, 4315.935260971088, 4359.760213188273, 4392.626626736731, 4493.797779099932, 4415.51429342772, 4450.198964186445, 4459.108178364324, 4461.107778444308, 4488.775561221943, 4184.456020717318, 4197.97901010496, 4310.82756689732, 4350.956490435118, 4374.737515749065, 4338.284183109783, 4353.238183317907, 4374.496932852699, 4417.160739459492, 4424.137293227822, 4358.150160718661, 4359.520452750195, 4371.322445021026, 4386.868393948154, 4415.359772832921, 4498.460184777848, 4511.593956543927, 4564.589186973189, 4574.794134263966, 4608.308753686973, 4975.925361119586, 4999.125153098194, 5003.349564556621, 5042.168042273057, 5054.949450505522, 5001.8499445016705, 5005.499450055002, 5012.824551140729, 5041.6722913010535, 5049.469805670426, 4588.105319462706, 4610.262358022734, 4642.303654451859, 4646.0, 4717.693349932243, 5072.644914855925, 5079.9840031993745, 5141.0232055909255, 5146.588272938156, 5160.458151894072, 4798.688085274446, 4890.682105663192, 4901.044296362175, 4910.508949105061, 4918.114739346952, 4929.088118698052, 4977.576905962961, 5015.6489045767175, 5074.416442109205, 5087.491250874883, 4981.402231732215, 5002.324686167393, 5012.649114562018, 5016.673916195436, 5024.196128619476, 4954.133026720309, 4957.3555437793575, 4959.479254678279, 4984.053029924303, 5001.7499125043605, 4181.519125300569, 4225.281702110648, 4231.936520952188, 4309.676774241944, 4314.22343978087, 3747.550293964687, 3766.642168993941, 3797.088698712289, 3798.1074447504816, 3801.847926082981, 4288.699791014599, 4331.220380331571, 4334.068175342317, 4337.175936572105, 4386.649068074546, 5099.847004589868, 5120.539151476385, 5127.2052831811125, 5135.460776618476, 5153.917677287812, 4245.002424430257, 4261.829526818955, 4265.125649241898, 4302.075053863435, 4323.113761678848, 4411.3824064630335, 4490.2142125127975, 4522.66080043998, 4529.705569138061, 4533.659975501851, 4491.550844915482, 4504.752238626841, 4517.774111294357, 4543.227651299287, 4546.863594092182, 5035.647504674637, 5054.494550544916, 5062.797488100582, 5070.340855688737, 5103.030424219386, 4429.734215947054, 4512.548745125461, 4521.615662668579, 4528.275475923836, 4545.886352841206, 4960.751962401793, 4977.576905962889, 4989.376327959005, 4993.525615066563, 5032.823851165192, 4988.176950803077, 5012.924806127984, 5017.874553136201, 5036.118679231046, 5072.923906141485, 4670.462896766915, 4814.951850481591, 4839.612830973584, 4885.487023862585, 4899.338589290543, 4872.439669437918, 4880.487548807324, 4886.53577910098, 4894.33926419943, 4904.166291730343, 4654.2785868190485, 4785.952140478551, 4786.353842231254, 4875.87810304731, 4888.291197776373, 4857.295692124693, 4917.655764096479, 4926.926096108633, 4939.357883475125, 4946.925796112989, 4793.113274044313, 4836.927446088382, 4854.271859221145, 4858.5384388483035, 4922.966177102705], "value": 4595.850124115939, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.7017680629266, 563.0849868962936, 587.2131343999042, 597.3459062326754, 610.407904332797, 39327.60672393275, 40146.799266003705, 40258.39612405813, 40380.394294085614, 40456.393154102676, 40204.59795402045, 40474.0, 40699.79650101745, 40827.59172408275, 40887.59112408882, 7317.926820731778, 7518.097828260617, 7658.693652253917, 9992.100710936014, 10187.032231937954, 9949.30354875159, 10048.74878128049, 10077.54651040705, 10079.949600252025, 10106.343087699313, 7425.517341372793, 10064.547095380725, 10113.190944724442, 10149.64476243328, 10153.746156346113, 9871.654492092779, 10187.235957303232, 10225.284230103896, 10471.528781204865, 10503.632372866989, 9957.103860652503, 9992.350497217658, 10082.747931301703, 10083.092521673085, 10092.646757363456, 39581.60418395808, 39615.0, 39722.0, 39866.40200396996, 39893.60106398928, 3266.395716792401, 3287.704106630391, 3395.7622966392364, 3464.2725027744204, 3477.3393055319407, 29994.100176994725, 30010.24974375658, 30376.0, 30658.38683226323, 31565.684343156503, 3522.964770352315, 3523.700485458739, 3553.662402071799, 3556.0, 3663.377225871608, 242363.0, 242930.0, 243452.0, 244202.0, 245689.0, 56455.15317270244, 56577.71711141418, 57325.0, 57358.42641573615, 57451.0, 35383.64616353855, 36396.0, 36405.45391819125, 38228.0, 38439.423408648894, 13248.668783280495, 13258.801117983237, 13273.800892986614, 13287.468501260035, 13329.466821327233, 11841.703957401134, 12062.51749929993, 12063.914247717748, 12080.456379462945, 12092.455839487244, 19409.767876694077, 19512.950675513606, 19586.31447899317, 19617.31339403114, 19678.0, 6082.878342433127, 7380.446466515033, 7384.704611815468, 7451.254874512505, 7475.813104672427, 829.4152622401193, 890.1207524302022, 925.0749250749251, 931.7856892914667, 951.7906060666643, 27875.860620696767, 28800.855995720307, 29118.417631647673, 29338.413231735245, 29362.265943351158, 988.8022395520925, 990.3166814897842, 1009.7627057641448, 1045.9320144190756, 1087.2660953856116, 15278.31247593861, 15293.847061529465, 15485.0, 15534.145621990672, 15716.92141539285, 363580.0, 364496.0, 366591.0, 368432.0, 368794.0, 50400.49599504031, 50811.23783143256, 51245.74377128165, 51354.74322628363, 51435.48564514307, 1163.8428812110426, 1229.932353720554, 1255.0837888341562, 1285.6207418811473, 1290.7224946636518, 28524.0, 29056.65848427458, 29267.414651707273, 29519.704802952554, 29718.702812971595, 43233.0, 43718.78140609276, 43819.56180438282, 44024.55975440205, 44273.77863110664, 269462.0, 272894.0, 274176.0, 275710.0, 275967.0, 23669.881650591637, 25804.483910322066, 26112.216633501026, 26472.470550589267, 28233.15300540987, 42803.357949631405, 43361.54245339472, 43526.56473435225, 43991.78004109959, 44497.55502445064, 36650.45024324691, 37298.627013729514, 37716.62283377131, 38139.0, 38371.80814095912, 36445.45331820078, 36836.0, 37212.81393593015, 37283.627163728015, 37853.43219851649, 36146.638533615376, 36799.44800827936, 36940.81529592335, 36949.26101477902, 37143.62856371402, 31926.36147276995, 33312.1671958203, 33754.0, 33806.32387352288, 33906.66093339134, 24612.261632151065, 25435.236942891745, 25459.599722015468, 25486.87256563705, 26054.60918086268], "value": 18193.1495456874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.142479408111, 389.108940526195, 390.7616354024045, 398.52177387135447, 399.628345638556, 15663.530094097181, 17230.82769172308, 17574.560635984108, 17623.11884405781, 17648.735268970944, 16725.581860453494, 17119.229634666437, 17297.0, 17506.299748010097, 17510.474685759415, 4838.51614838516, 5034.244863270502, 5260.763265653036, 5340.412554619008, 5386.515213630772, 3720.1071742781673, 4654.883627909296, 6105.32841387447, 6119.724612392453, 6246.406591373812, 6091.482224010964, 6142.600730952474, 6233.189685340899, 6290.3709629037185, 6297.118403423525, 5974.253218347707, 6035.788747393842, 6191.94736894729, 6216.844578885519, 6225.844353891143, 5294.867628309285, 5392.4337944515655, 5421.83734487966, 5433.6196466247375, 5469.179623056533, 20948.37154885356, 21108.0, 21167.364979050653, 21215.893920530452, 21291.0, 1999.7600287965392, 2016.9697454538193, 2164.6536554151417, 2422.0917156066475, 2566.961495577568, 12926.612201633967, 13155.856679607676, 13427.731445371039, 13742.312884355842, 13747.656308592364, 1748.3006797281062, 1794.9820501795075, 1813.610073834132, 1816.727490876366, 1818.8544916406656, 63657.0, 64744.3525564743, 65804.67097664528, 66919.33080669228, 67261.66369168172, 9667.951660241795, 9793.608255669837, 10144.442055687008, 10158.746031349276, 10233.539490722935, 13747.656308592364, 13801.930990344985, 13803.930980345234, 13846.238456884766, 13849.16904985704, 7679.116901556281, 7683.116441609286, 7701.075870895528, 7747.806304842424, 7809.882851757228, 7362.3741981932135, 7440.627968601549, 7441.479096463196, 7527.510711803715, 7544.773656790305, 6185.319614842364, 6420.711068001951, 6425.614463132227, 6437.002264648987, 6512.185976752906, 1813.718873574598, 1850.8704390692792, 1850.9259629614664, 1857.0, 1888.225827410755, 892.2727976698969, 892.848215803315, 982.8918818929913, 992.5235886774389, 1002.1832206751474, 16729.498115056325, 16997.815666221675, 17019.14904254807, 17138.228779704943, 17318.220680069426, 928.6563971330651, 938.3619138985555, 948.660437988007, 949.4588084791602, 967.2262190247915, 8686.435381700168, 9868.358556693793, 10049.899501005042, 10056.949715251523, 10181.694549163536, 312053.0, 314830.0, 317041.0, 428384.0, 446965.0, 79651.20348796438, 83647.5817620908, 84572.0, 85159.5742021286, 85406.572967136, 963.0946909904667, 975.5756246032998, 984.3552473130111, 1001.6577785766962, 1003.6437064841876, 15608.141552214283, 15886.364545418053, 15937.36250549965, 16033.35866565371, 16367.0, 35062.82468587641, 36410.45384319184, 36474.635253647124, 36692.63307366892, 36734.44898326474, 49928.253946033314, 51938.0, 52538.737306313225, 52732.47267527429, 52810.94378112493, 7480.551166930001, 7750.0699916010435, 7904.051513818378, 7926.524408535506, 8073.071596766212, 8544.957275213585, 11783.587574434854, 11972.58095966637, 12048.518059277882, 12161.148719589544, 9755.609775608897, 10164.644237451654, 10433.530491127765, 10491.160707143257, 10805.405702686114, 6037.0, 10133.493325333557, 10347.793044139225, 10364.637237696645, 10365.326253793479, 10316.17470602365, 10363.84454233172, 10594.15246780271, 10660.413677247516, 11008.34874768791, 7781.455298129303, 7833.960830195812, 7905.802354941173, 7948.165442628672, 7948.920510794818, 9970.700878973643, 10186.134178594903, 10231.079202871777, 10243.948780256349, 10247.282690211614], "value": 8615.601517517103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.3368282176086, 1484.7030593881227, 1525.6796072824704, 1668.557832174473, 1810.1492298619644, 7316.670749816258, 7763.417743669226, 7789.844203115941, 7952.0, 7992.040955085398, 7684.9615751921165, 7846.136924938252, 7850.568218747981, 7859.410544209179, 7870.212978702127, 2141.4539292480395, 2174.3803016140405, 2174.521605246843, 2181.378307182453, 2181.901814418347, 2211.4913569878936, 2222.8777417242045, 2239.261043855524, 2267.399139228106, 2272.068451934707, 2150.1506904772605, 2162.643163877958, 2177.401214665964, 2177.923772667957, 2201.8128459081, 2016.3850025742142, 2019.2932473634257, 2028.7058376535394, 2034.5829105033433, 2040.357287454447, 2076.7092607034874, 2109.0298462707174, 2110.757262914754, 2114.629939760551, 2114.93655190343, 7512.924870751277, 7763.611819409007, 7795.0, 7845.843083138362, 7846.0, 4545.11370282795, 4660.4174478190225, 4674.0, 4706.599939005188, 4716.834910778106, 2821.8024738268123, 2831.0, 2846.2599724071683, 2854.0581608069288, 2906.564015397686, 922.2115091596722, 923.1414784250644, 923.9697737023238, 966.5940305071816, 986.4623780039824, 10478.685639430752, 10589.205809564237, 10594.894051059468, 10609.73475663107, 10623.150147988143, 3959.0, 3984.362501999666, 4046.069404037088, 4085.632293093636, 4111.259973204792, 8381.329493640495, 8432.114627964098, 8459.0, 8461.873071903927, 8495.490270583785, 4470.150671372428, 4508.594226519629, 4552.476465206478, 4565.840195593139, 4569.725816450957, 3691.040329514292, 4068.572799856032, 4152.397902304149, 4214.325707886724, 4217.7891105445215, 3344.2308269097757, 3410.334984677964, 3439.604445488801, 3454.2227998700596, 3463.653634636516, 1003.5885287032281, 1007.8488226765897, 1009.8384258518602, 1012.3875055591261, 1019.0166489337824, 792.9008873890764, 854.0733304364834, 915.3821170709745, 920.5397301349325, 924.1082355526949, 5136.922946155811, 5493.752781124859, 5568.136938774496, 5624.746886390122, 5795.797147099831, 888.2316795971439, 921.3412410126791, 947.8625599288065, 953.9761505962267, 991.7173605522391, 3699.667029967316, 3740.382836831947, 3795.5065841440987, 3813.656770890633, 3893.766374017568, 8698.521581313089, 8901.465912045298, 9031.36780425377, 9152.496612686366, 9168.312376571785, 8912.331575131891, 8994.50530220831, 9011.63953441868, 9147.72556823283, 9159.267258619295, 6952.2352541221435, 7276.653819043494, 7294.8905766413545, 7358.816029599196, 7490.962545187348, 5544.584156188222, 5653.491185793298, 5820.592558520862, 5832.066869301061, 5917.526597872074, 8413.789655258422, 8950.14973577509, 9064.274858011475, 9142.222911052635, 9185.035571265189, 9081.863772043293, 9218.492982885737, 9280.535973201178, 9301.023392543957, 9392.953035235054, 5922.851928701644, 6669.7665581704405, 6717.2946840581035, 6779.966100169468, 6834.2140653825445, 7625.542467451749, 7729.458937874295, 7732.536047837148, 7749.612519374122, 7781.338586220235, 6676.766313179015, 6707.731690732316, 6885.173779146535, 6935.237123916264, 7085.82285442868, 6702.229243637044, 6753.3246675332075, 6770.221424536045, 6801.761938332134, 6830.692618832264, 6381.3937675920715, 6403.96798016007, 6471.2234531856475, 6479.157709497735, 6494.772682956074, 4818.373611430492, 4845.079434907357, 4845.466998630078, 4938.629602779734, 5010.398752149766, 4685.882852928704, 4742.88142796419, 4743.952560474351, 4804.711717296974, 4819.084373968934], "value": 4142.491781522258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.0980366740121, 317.13106089315283, 319.7234392250703, 321.7667191286318, 322.05798040730883, 4634.745089020111, 4662.370579971703, 4692.554207350305, 4701.9059618807605, 4711.199096153654, 4578.031446478013, 4594.540545945404, 4615.561521655437, 4633.0, 4635.096156249533, 3451.430513965199, 3574.1779390740144, 3673.934558977893, 3697.3899306614376, 3701.1857391373856, 3666.5233519642543, 3681.7606855554436, 3685.852565897361, 3752.68102211311, 3754.4180651998986, 3479.2519608284215, 3661.6085887362765, 3680.613535578766, 3698.0, 3713.832877520518, 3548.4322508398664, 3622.800745958971, 3666.816659167058, 3667.7982710950887, 3673.5040769496045, 3249.5613092232484, 3252.8373581321075, 3259.445894197992, 3282.1302354875975, 3289.703926646613, 4461.977690111561, 4467.0, 4478.4178056852725, 4491.652504248745, 4491.842785502492, 3924.3132451820816, 4157.438745769313, 4157.605027522381, 4174.977130603022, 4196.17466402113, 4841.7337046462435, 4857.805687772485, 4860.149473842063, 4880.316755654211, 4891.6820406673805, 3542.875999340011, 3556.822158892045, 3561.821908904544, 3564.9821750891338, 3594.4967704521387, 5003.199488081926, 5074.071852695989, 5120.180771076647, 5138.10083235436, 5168.173092305251, 3589.138606734417, 3589.838457269429, 3597.6582224688614, 3636.6726994570618, 3644.507991421124, 3634.6183650716293, 3683.5211422515436, 3686.944695829565, 3691.5201023866725, 3693.759905606127, 4154.961259685078, 4161.8959526012095, 4163.7293575917465, 4168.687348448879, 4178.22702799983, 4579.427571553556, 4883.145449546315, 4892.119418504703, 4910.705357678551, 4912.1158191525865, 1252.2861968677767, 1257.4972907375782, 1269.1940617707821, 1269.7714411406037, 1270.5172034626967, 805.959702014897, 817.979550511242, 855.2730179347504, 877.8814859993819, 879.9484615884085, 4222.282212023963, 4244.129953359554, 4252.638525725348, 4257.467816522934, 4281.892952676208, 4909.484504127086, 4924.8030078797165, 4939.481354457802, 4942.975285123552, 4948.703077815343, 4106.733062350938, 4194.832206711759, 4235.385869048971, 4242.151569686075, 4255.319148936155, 2718.768904643088, 2730.3856632257584, 2744.88832023027, 2746.3546066674317, 2757.076379412879, 4567.634589232854, 4581.358609794632, 4606.6314694825005, 4619.4687610925175, 4619.544843374327, 5067.883251800116, 5145.562627176732, 5152.763336799141, 5163.070647283525, 5230.555402790806, 4459.108178364275, 4476.820927162877, 4481.932771008437, 4551.726896386162, 4561.794719237642, 5000.974995125147, 5012.3233363495465, 5026.798928042837, 5032.169692000925, 5037.748112594282, 4743.885186980988, 4945.901081978268, 4949.554540091409, 4987.276844857548, 5000.699958002531, 4426.468823741172, 4524.773761311987, 4541.43232095988, 4545.59089681917, 4555.863324100283, 3576.177479179751, 3585.31878943, 3597.4783656370205, 3621.764585301947, 3627.8186090695885, 4864.27035944597, 5000.0, 5019.4863595482575, 5023.844515761322, 5031.647784655039, 4884.584810291023, 4909.214525675875, 4911.533404326583, 4919.3358896549935, 4921.778519966681, 4879.975600121977, 4919.950800491949, 4927.384076990376, 4928.901421971469, 4947.54047555979, 4615.307703844316, 4755.714657120584, 4766.523347665206, 4825.879353016203, 4870.1233777920315, 4885.633577481632, 4921.803127874845, 4942.456329803646, 4949.133901567283, 4949.935763810798, 4803.687760295569, 4820.927686084781, 4835.492273311252, 4859.514048595112, 4891.241857512091], "value": 3693.3204649698946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2340272505693, 735.0884902720626, 749.0524486524544, 767.3745897093868, 810.8054067023916, 13873.930630346847, 14588.489402870888, 14634.121952682834, 14732.410703571872, 15010.324535395906, 14558.636034099127, 14611.269436528157, 14643.853561464382, 14690.118592884408, 14721.337539810707, 682.4676752133319, 823.0575990490885, 863.7408777366796, 872.2890843962182, 875.8598624220094, 841.5539763925129, 845.1126317366771, 851.1318455175717, 852.8209076094028, 855.4567849415604, 887.2547060469204, 900.0279697926223, 902.1159263921361, 904.2043002158125, 904.5477261369315, 708.3447810775039, 878.0341624213378, 898.7977705016384, 899.1143723432414, 905.5381755304776, 665.3811954881958, 665.9134312539387, 669.3239827773934, 669.4276393683427, 669.7287598522606, 12942.870571294261, 12958.87041129586, 12984.740305193844, 12992.480300787956, 13031.674208144777, 11606.941965290203, 11919.0, 11926.642200733992, 12045.63863084109, 12262.754744905142, 10998.230123891331, 11034.227604067719, 11271.211015228937, 11279.492422840993, 11961.521539138424, 4166.208420400114, 4229.259879521102, 4265.53079161292, 4394.934075988863, 4405.31717583775, 45213.547864521264, 45280.77359613214, 45375.092498149854, 45423.545764542265, 45634.77182614099, 9823.017698230262, 9861.309708320348, 10316.587336506456, 10399.376037437778, 10768.784624307627, 17350.39273625417, 17581.824181758275, 17717.0, 17726.20232089559, 17893.463196104138, 7160.212376638566, 7165.283471652897, 7182.42540596751, 7212.423006159494, 7297.708091676273, 3850.4994350734223, 3936.232434675268, 3980.7611543307494, 4016.9957510622344, 4070.7354021988476, 2863.4559433707527, 2944.175630823373, 2947.4252520758673, 2950.0, 2951.9852400738287, 521.9321488206584, 544.7031367904501, 545.7571380735535, 550.0841099569252, 561.332014902265, 473.983410580628, 530.3662123762067, 534.2627174499244, 536.7799202327027, 603.101378945377, 7711.273932400336, 8045.758627241192, 8105.230003149692, 8106.554139522383, 8170.591470426455, 596.3648714119449, 602.1148911100762, 608.0301918440081, 615.2524682510771, 619.5121466145572, 3756.492873462102, 3769.246150769857, 3816.713746469026, 3863.0421332056053, 3872.806359682061, 50648.74675626598, 51334.48665513372, 51653.741731291855, 52004.47995520072, 52279.73860130675, 46909.29636055462, 47832.282515762294, 47971.0, 48292.5170748288, 49431.0, 41849.581504185175, 42293.78853105715, 42626.0, 42695.57304426978, 42888.57111428846, 7591.58246296459, 7719.150893401609, 7775.339096176888, 7815.14033456308, 7986.881836543005, 25636.23091307264, 25968.740312596634, 27109.322266943484, 28813.135605931857, 29363.85318073396, 37875.621243788315, 38110.42834357431, 38387.04032399101, 38536.42195367128, 39180.608193917695, 10650.307729997836, 10856.402897840695, 11602.88397116018, 11647.835216478285, 11654.184207105422, 12055.51777928873, 12329.50681972711, 12331.568395106127, 12645.873541264838, 12943.417546210254, 11624.535018599161, 11847.585334513251, 12146.331951742386, 12389.75220495603, 12390.752184956431, 11513.53945842157, 11742.70643233926, 11923.284602923506, 12270.938645306716, 12502.624921252376, 11105.0, 11221.775564488502, 11887.405629718307, 11960.461779219782, 11985.700357491132, 9663.9033609663, 9693.321467497208, 9730.318877678494, 9911.256655750703, 10053.949730251303, 9843.0, 9946.552405141641, 9968.202543796624, 9990.600375984879, 10095.0], "value": 6196.6810239759625, "unit": "score"}], "name": "dromaeo_css", "value": 6393.546211783014, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 110.0, 116.0, 116.0, 115.0, 116.0, 115.0, 117.0, 115.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 140.0, 160.0, 214.0, 141.0, 158.0, 161.0, 137.0, 192.0, 140.0], "value": 160.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 162.0, 162.0, 163.0, 167.0, 163.0, 162.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 147.0, 77.0, 78.0, 78.0, 76.0, 126.0, 77.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 152.0, 95.0, 96.0, 95.0, 124.0, 95.0, 97.0, 120.0], "value": 106.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 118.0, 131.0, 117.0, 117.0, 117.0, 119.0, 118.0], "value": 119.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 150.0, 149.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0], "value": 67.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 86.0, 86.0, 86.0, 92.0, 88.0, 87.0, 147.0, 87.0], "value": 93.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 141.0, 140.0, 139.0, 139.0, 139.0, 142.0, 156.0, 157.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 189.0, 183.0, 183.0, 183.0, 180.0, 181.0, 179.0, 180.0, 177.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0, 68.0, 70.0, 70.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1620.1, "alertThreshold": 2.0}]} 17:21:04 INFO - Return code: 0 17:21:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:21:04 ERROR - # TBPL SUCCESS # 17:21:04 INFO - Running post-action listener: _resource_record_post_action 17:21:04 INFO - ##### 17:21:04 INFO - ##### Finished run-tests step (success) 17:21:04 INFO - ##### 17:21:04 INFO - Running post-run listener: _resource_record_post_run 17:21:05 INFO - Total resource usage - Wall time: 1197s; CPU: 26.0%; Read bytes: 4096; Write bytes: 520413184; Read time: 12; Write time: 512980 17:21:05 INFO - TinderboxPrint: CPU usage
25.5% 17:21:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:21:05 INFO - TinderboxPrint: I/O write bytes / time
520,413,184 / 512,980 17:21:05 INFO - TinderboxPrint: CPU idle
7,114.0 (74.4%) 17:21:05 INFO - TinderboxPrint: CPU user
2,406.1 (25.2%) 17:21:05 INFO - TinderboxPrint: Swap in / out
0 / 0 17:21:05 INFO - install - Wall time: 16s; CPU: 27.0%; Read bytes: 0; Write bytes: 234766336; Read time: 0; Write time: 290708 17:21:05 INFO - run-tests - Wall time: 1182s; CPU: 26.0%; Read bytes: 4096; Write bytes: 285646848; Read time: 12; Write time: 222272 17:21:05 INFO - Running post-run listener: _upload_blobber_files 17:21:05 INFO - Blob upload gear active. 17:21:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:21:05 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 17:21:05 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'] 17:21:05 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 17:21:06 INFO - (blobuploader) - INFO - Open directory for files ... 17:21:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:21:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:21:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:21:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:06 INFO - (blobuploader) - INFO - Done attempting. 17:21:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:21:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:21:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:21:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:07 INFO - (blobuploader) - INFO - Done attempting. 17:21:07 INFO - (blobuploader) - INFO - Iteration through files over. 17:21:07 INFO - Return code: 0 17:21:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:21:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:21:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d6fcfab1f988634c7c7d00129abd69079fbef9e3b7c61ccab5167393a9bd01d28eff66bbe2f953a61133c5bf9100eda53dab5d878b9630b0e4d3d8190fd3c2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3617bc27e080073b268504c78918a51a7bb2ff16a71eb7d00dedd761bf9b9a0e00aa45c4f4cde941ccb03a9fa421d8f0892745031df86018be8ced688ba6270b"} 17:21:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:21:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:21:07 INFO - Contents: 17:21:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d6fcfab1f988634c7c7d00129abd69079fbef9e3b7c61ccab5167393a9bd01d28eff66bbe2f953a61133c5bf9100eda53dab5d878b9630b0e4d3d8190fd3c2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3617bc27e080073b268504c78918a51a7bb2ff16a71eb7d00dedd761bf9b9a0e00aa45c4f4cde941ccb03a9fa421d8f0892745031df86018be8ced688ba6270b"} 17:21:07 INFO - Running post-run listener: copy_logs_to_upload_dir 17:21:07 INFO - Copying logs to upload dir... 17:21:07 INFO - mkdir: /builds/slave/test/build/upload/logs 17:21:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.750874 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-12 17:21:07.689844) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 17:21:07.693903) ========= 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=62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713 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/2d6fcfab1f988634c7c7d00129abd69079fbef9e3b7c61ccab5167393a9bd01d28eff66bbe2f953a61133c5bf9100eda53dab5d878b9630b0e4d3d8190fd3c2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3617bc27e080073b268504c78918a51a7bb2ff16a71eb7d00dedd761bf9b9a0e00aa45c4f4cde941ccb03a9fa421d8f0892745031df86018be8ced688ba6270b"} build_url:https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005518 build_url: 'https://queue.taskcluster.net/v1/task/IzrobNLTT_mCF9KEzf2AmA/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/2d6fcfab1f988634c7c7d00129abd69079fbef9e3b7c61ccab5167393a9bd01d28eff66bbe2f953a61133c5bf9100eda53dab5d878b9630b0e4d3d8190fd3c2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3617bc27e080073b268504c78918a51a7bb2ff16a71eb7d00dedd761bf9b9a0e00aa45c4f4cde941ccb03a9fa421d8f0892745031df86018be8ced688ba6270b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 17:21:07.707878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:21:07.708177) ========= 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=62c568580acbfdaac3eec7be000001dc-1463097632.815855-2097182713 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002139 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:21:07.788251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 17:21:07.788588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 17:21:07.788904) ========= ========= Total master_lag: 0.16 =========