builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1461711125.34 results: success (0) buildid: 20160426142902 builduid: 94475adab2ed44fbb18e832244c7fdd0 revision: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.342327) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.342780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.343094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.370531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.370877) ========= 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=574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 15:52:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2016-04-26 15:52:05 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144200 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.531787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.532121) ========= 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=574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014693 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.582949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:05.583331) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 937d57e8b4f0fa5f16231563ab0425eee9d40c82 --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 937d57e8b4f0fa5f16231563ab0425eee9d40c82 --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=574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 15:52:06,102 truncating revision to first 12 chars 2016-04-26 15:52:06,102 Setting DEBUG logging. 2016-04-26 15:52:06,102 attempt 1/10 2016-04-26 15:52:06,102 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/937d57e8b4f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 15:52:06,390 unpacking tar archive at: fx-team-937d57e8b4f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598770 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:06.194991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:06.195283) ========= script_repo_revision: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:06.195719) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:06.195979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:52:06.205876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-26 15:52:06.206132) ========= /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=574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:52:06 INFO - MultiFileLogger online at 20160426 15:52:06 in /builds/slave/test 15:52:06 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 15:52:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:06 INFO - {'append_to_log': False, 15:52:06 INFO - 'base_work_dir': '/builds/slave/test', 15:52:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:52:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:06 INFO - 'branch': 'Fx-Team-Non-PGO', 15:52:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:06 INFO - 'config_files': ('talos/linux_config.py',), 15:52:06 INFO - 'default_actions': ('clobber', 15:52:06 INFO - 'read-buildbot-config', 15:52:06 INFO - 'download-and-extract', 15:52:06 INFO - 'populate-webroot', 15:52:06 INFO - 'create-virtualenv', 15:52:06 INFO - 'install', 15:52:06 INFO - 'run-tests'), 15:52:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:06 INFO - 'download_minidump_stackwalk': True, 15:52:06 INFO - 'download_symbols': 'ondemand', 15:52:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:06 INFO - 'installer_path': 'installer.exe', 15:52:06 INFO - 'log_level': 'info', 15:52:06 INFO - 'log_name': 'talos', 15:52:06 INFO - 'log_to_console': True, 15:52:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:52:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:52:06 INFO - 'opt_config_files': (), 15:52:06 INFO - 'pip_index': False, 15:52:06 INFO - 'sps_profile': False, 15:52:06 INFO - 'sps_profile_interval': 0, 15:52:06 INFO - 'suite': 'dromaeojs', 15:52:06 INFO - 'system_bits': '32', 15:52:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:06 INFO - 'title': 'talos-linux64-ix-044', 15:52:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:06 INFO - 'use_talos_json': True, 15:52:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:06 INFO - 'work_dir': 'build'} 15:52:06 INFO - ##### 15:52:06 INFO - ##### Running clobber step. 15:52:06 INFO - ##### 15:52:06 INFO - Running pre-action listener: _resource_record_pre_action 15:52:06 INFO - Running main action method: clobber 15:52:06 INFO - rmtree: /builds/slave/test/build 15:52:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:07 INFO - Running post-action listener: _resource_record_post_action 15:52:07 INFO - ##### 15:52:07 INFO - ##### Running read-buildbot-config step. 15:52:07 INFO - ##### 15:52:07 INFO - Running pre-action listener: _resource_record_pre_action 15:52:07 INFO - Running main action method: read_buildbot_config 15:52:07 INFO - Using buildbot properties: 15:52:07 INFO - { 15:52:07 INFO - "project": "", 15:52:07 INFO - "product": "firefox", 15:52:07 INFO - "script_repo_revision": "production", 15:52:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:52:07 INFO - "repository": "", 15:52:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:52:07 INFO - "buildid": "20160426142902", 15:52:07 INFO - "pgo_build": "False", 15:52:07 INFO - "basedir": "/builds/slave/test", 15:52:07 INFO - "buildnumber": 1712, 15:52:07 INFO - "slavename": "talos-linux64-ix-044", 15:52:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:52:07 INFO - "platform": "ubuntu64_hw", 15:52:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:52:07 INFO - "branch": "fx-team", 15:52:07 INFO - "repo_path": "integration/fx-team", 15:52:07 INFO - "revision": "937d57e8b4f0fa5f16231563ab0425eee9d40c82", 15:52:07 INFO - "stage_platform": "linux64", 15:52:07 INFO - "builduid": "94475adab2ed44fbb18e832244c7fdd0", 15:52:07 INFO - "slavebuilddir": "test" 15:52:07 INFO - } 15:52:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:52:07 INFO - Running post-action listener: _resource_record_post_action 15:52:07 INFO - ##### 15:52:07 INFO - ##### Running download-and-extract step. 15:52:07 INFO - ##### 15:52:07 INFO - Running pre-action listener: _resource_record_pre_action 15:52:07 INFO - Running main action method: download_and_extract 15:52:07 INFO - mkdir: /builds/slave/test/build/tests 15:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:07 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:52:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:52:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:52:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:19 INFO - Downloaded 1361 bytes. 15:52:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:52:19 INFO - Using the following test package requirements: 15:52:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:52:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:52:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:19 INFO - u'jsshell-linux-x86_64.zip'], 15:52:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:52:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:52:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:52:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:52:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:52:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:19 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:52:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:26 INFO - Downloaded 22291062 bytes. 15:52:26 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'] 15:52:26 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 15:52:27 INFO - Return code: 0 15:52:27 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 15:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:27 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:30 INFO - Downloaded 22291062 bytes. 15:52:30 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'] 15:52:30 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 15:52:31 INFO - Return code: 0 15:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:31 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:52:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:32 INFO - Downloaded 10840145 bytes. 15:52:32 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'] 15:52:32 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 15:52:32 INFO - Return code: 0 15:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:32 INFO - https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VtEy-H3WSUmJS95rBS74jg/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 15:52:34 INFO - Downloaded 54817608 bytes. 15:52:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:52:34 INFO - mkdir: /builds/slave/test/properties 15:52:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:34 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:34 INFO - Contents: 15:52:34 INFO - build_url:https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:52:37 INFO - Running post-action listener: _resource_record_post_action 15:52:37 INFO - Running post-action listener: set_extra_try_arguments 15:52:37 INFO - ##### 15:52:37 INFO - ##### Running populate-webroot step. 15:52:37 INFO - ##### 15:52:37 INFO - Running pre-action listener: _resource_record_pre_action 15:52:37 INFO - Running main action method: populate_webroot 15:52:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:37 INFO - '--tppagecycles', 15:52:37 INFO - '7'], 15:52:37 INFO - 'tests': ['tsvgm']}}, 15:52:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:52:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:52:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:37 INFO - 'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:37 INFO - 'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['damp', 'tps']}, 15:52:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:37 INFO - 'tests': ['damp', 'tps']}, 15:52:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['dromaeo_dom']}, 15:52:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['a11yr', 15:52:37 INFO - 'ts_paint', 15:52:37 INFO - 'tpaint', 15:52:37 INFO - 'sessionrestore', 15:52:37 INFO - 'sessionrestore_no_auto_restore', 15:52:37 INFO - 'tabpaint']}, 15:52:37 INFO - 'other-e10s': {'tests': ['a11yr', 15:52:37 INFO - 'ts_paint', 15:52:37 INFO - 'tpaint', 15:52:37 INFO - 'sessionrestore', 15:52:37 INFO - 'sessionrestore_no_auto_restore', 15:52:37 INFO - 'tabpaint']}, 15:52:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:52:37 INFO - 'ts_paint', 15:52:37 INFO - 'tpaint', 15:52:37 INFO - 'sessionrestore', 15:52:37 INFO - 'sessionrestore_no_auto_restore', 15:52:37 INFO - 'tabpaint']}, 15:52:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:52:37 INFO - 'ts_paint', 15:52:37 INFO - 'tpaint', 15:52:37 INFO - 'sessionrestore', 15:52:37 INFO - 'sessionrestore_no_auto_restore', 15:52:37 INFO - 'tabpaint']}, 15:52:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['a11yr', 15:52:37 INFO - 'ts_paint', 15:52:37 INFO - 'tpaint', 15:52:37 INFO - 'sessionrestore', 15:52:37 INFO - 'sessionrestore_no_auto_restore', 15:52:37 INFO - 'tabpaint']}, 15:52:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['a11yr', 15:52:37 INFO - 'ts_paint', 15:52:37 INFO - 'tpaint', 15:52:37 INFO - 'sessionrestore', 15:52:37 INFO - 'sessionrestore_no_auto_restore', 15:52:37 INFO - 'tabpaint']}, 15:52:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['tsvgx', 15:52:37 INFO - 'tsvgr_opacity', 15:52:37 INFO - 'tart', 15:52:37 INFO - 'tscrollx', 15:52:37 INFO - 'cart']}, 15:52:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:52:37 INFO - 'tsvgr_opacity', 15:52:37 INFO - 'tart', 15:52:37 INFO - 'tscrollx', 15:52:37 INFO - 'cart']}, 15:52:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:37 INFO - 'talos_options': ['--disable-e10s'], 15:52:37 INFO - 'tests': ['tp5o']}, 15:52:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:37 INFO - 'tests': ['tp5o']}, 15:52:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:37 INFO - 'talos_options': ['--disable-e10s', 15:52:37 INFO - '--xperf_path', 15:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:37 INFO - 'tests': ['tp5n']}, 15:52:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:37 INFO - 'talos_options': ['--xperf_path', 15:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:37 INFO - 'tests': ['tp5n']}}, 15:52:37 INFO - 'talos.zip': {'path': '', 15:52:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:37 INFO - Running post-action listener: _resource_record_post_action 15:52:37 INFO - ##### 15:52:37 INFO - ##### Running create-virtualenv step. 15:52:37 INFO - ##### 15:52:37 INFO - Running pre-action listener: _resource_record_pre_action 15:52:37 INFO - Running main action method: create_virtualenv 15:52:37 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:52:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:37 INFO - Using real prefix '/usr' 15:52:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:38 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:40 INFO - Installing pip.................done. 15:52:40 INFO - Return code: 0 15:52:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:40 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 0x7f3f1e76df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:52:40 INFO - Using env: {'DISPLAY': ':0', 15:52:40 INFO - 'HOME': '/home/cltbld', 15:52:40 INFO - 'LANG': 'en_US.UTF-8', 15:52:40 INFO - 'LANGUAGE': 'en_US:en', 15:52:40 INFO - 'LOGNAME': 'cltbld', 15:52:40 INFO - 'MAIL': '/var/mail/cltbld', 15:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:40 INFO - 'MOZ_NO_REMOTE': '1', 15:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:40 INFO - 'NO_EM_RESTART': '1', 15:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:40 INFO - 'PWD': '/builds/slave/test', 15:52:40 INFO - 'SHELL': '/bin/bash', 15:52:40 INFO - 'SHLVL': '1', 15:52:40 INFO - 'TERM': 'linux', 15:52:40 INFO - 'TMOUT': '86400', 15:52:40 INFO - 'USER': 'cltbld', 15:52:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:40 INFO - '_': '/tools/buildbot/bin/python'} 15:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:52:40 INFO - Cleaning up... 15:52:40 INFO - Return code: 0 15:52:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:40 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 0x7f3f1e76df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:52:40 INFO - Using env: {'DISPLAY': ':0', 15:52:40 INFO - 'HOME': '/home/cltbld', 15:52:40 INFO - 'LANG': 'en_US.UTF-8', 15:52:40 INFO - 'LANGUAGE': 'en_US:en', 15:52:40 INFO - 'LOGNAME': 'cltbld', 15:52:40 INFO - 'MAIL': '/var/mail/cltbld', 15:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:40 INFO - 'MOZ_NO_REMOTE': '1', 15:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:40 INFO - 'NO_EM_RESTART': '1', 15:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:40 INFO - 'PWD': '/builds/slave/test', 15:52:40 INFO - 'SHELL': '/bin/bash', 15:52:40 INFO - 'SHLVL': '1', 15:52:40 INFO - 'TERM': 'linux', 15:52:40 INFO - 'TMOUT': '86400', 15:52:40 INFO - 'USER': 'cltbld', 15:52:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:40 INFO - '_': '/tools/buildbot/bin/python'} 15:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:40 INFO - Downloading/unpacking psutil>=0.7.1 15:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:42 INFO - Installing collected packages: psutil 15:52:42 INFO - Running setup.py install for psutil 15:52:42 INFO - building 'psutil._psutil_linux' extension 15:52:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:52:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:52:43 INFO - building 'psutil._psutil_posix' extension 15:52:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:52:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:52:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:43 INFO - Successfully installed psutil 15:52:43 INFO - Cleaning up... 15:52:43 INFO - Return code: 0 15:52:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:43 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 0x7f3f1e76df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:52:43 INFO - Using env: {'DISPLAY': ':0', 15:52:43 INFO - 'HOME': '/home/cltbld', 15:52:43 INFO - 'LANG': 'en_US.UTF-8', 15:52:43 INFO - 'LANGUAGE': 'en_US:en', 15:52:43 INFO - 'LOGNAME': 'cltbld', 15:52:43 INFO - 'MAIL': '/var/mail/cltbld', 15:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:43 INFO - 'MOZ_NO_REMOTE': '1', 15:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:43 INFO - 'NO_EM_RESTART': '1', 15:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:43 INFO - 'PWD': '/builds/slave/test', 15:52:43 INFO - 'SHELL': '/bin/bash', 15:52:43 INFO - 'SHLVL': '1', 15:52:43 INFO - 'TERM': 'linux', 15:52:43 INFO - 'TMOUT': '86400', 15:52:43 INFO - 'USER': 'cltbld', 15:52:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:43 INFO - '_': '/tools/buildbot/bin/python'} 15:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:52:45 INFO - Installing collected packages: mozsystemmonitor 15:52:45 INFO - Running setup.py install for mozsystemmonitor 15:52:45 INFO - Successfully installed mozsystemmonitor 15:52:45 INFO - Cleaning up... 15:52:45 INFO - Return code: 0 15:52:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f1e76df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:52:45 INFO - Using env: {'DISPLAY': ':0', 15:52:45 INFO - 'HOME': '/home/cltbld', 15:52:45 INFO - 'LANG': 'en_US.UTF-8', 15:52:45 INFO - 'LANGUAGE': 'en_US:en', 15:52:45 INFO - 'LOGNAME': 'cltbld', 15:52:45 INFO - 'MAIL': '/var/mail/cltbld', 15:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:45 INFO - 'MOZ_NO_REMOTE': '1', 15:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:45 INFO - 'NO_EM_RESTART': '1', 15:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:45 INFO - 'PWD': '/builds/slave/test', 15:52:45 INFO - 'SHELL': '/bin/bash', 15:52:45 INFO - 'SHLVL': '1', 15:52:45 INFO - 'TERM': 'linux', 15:52:45 INFO - 'TMOUT': '86400', 15:52:45 INFO - 'USER': 'cltbld', 15:52:45 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:45 INFO - '_': '/tools/buildbot/bin/python'} 15:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:45 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:47 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:48 INFO - Downloading docopt-0.6.1.tar.gz 15:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:48 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:48 INFO - Running setup.py install for blobuploader 15:52:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:48 INFO - Running setup.py install for requests 15:52:48 INFO - Running setup.py install for docopt 15:52:49 INFO - Successfully installed blobuploader requests docopt 15:52:49 INFO - Cleaning up... 15:52:49 INFO - Return code: 0 15:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:49 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 0x7f3f1e76df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:52:49 INFO - Using env: {'DISPLAY': ':0', 15:52:49 INFO - 'HOME': '/home/cltbld', 15:52:49 INFO - 'LANG': 'en_US.UTF-8', 15:52:49 INFO - 'LANGUAGE': 'en_US:en', 15:52:49 INFO - 'LOGNAME': 'cltbld', 15:52:49 INFO - 'MAIL': '/var/mail/cltbld', 15:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:49 INFO - 'MOZ_NO_REMOTE': '1', 15:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:49 INFO - 'NO_EM_RESTART': '1', 15:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:49 INFO - 'PWD': '/builds/slave/test', 15:52:49 INFO - 'SHELL': '/bin/bash', 15:52:49 INFO - 'SHLVL': '1', 15:52:49 INFO - 'TERM': 'linux', 15:52:49 INFO - 'TMOUT': '86400', 15:52:49 INFO - 'USER': 'cltbld', 15:52:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:49 INFO - '_': '/tools/buildbot/bin/python'} 15:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:49 INFO - Running setup.py (path:/tmp/pip-8UVh82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:49 INFO - Running setup.py (path:/tmp/pip-EIgFXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:49 INFO - Running setup.py (path:/tmp/pip-p_5eyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:49 INFO - Running setup.py (path:/tmp/pip-gcEmZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:49 INFO - Running setup.py (path:/tmp/pip-Ig6MsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:49 INFO - Running setup.py (path:/tmp/pip-XK7LxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:49 INFO - Running setup.py (path:/tmp/pip-dvdVHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:49 INFO - Running setup.py (path:/tmp/pip-ST_tQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:49 INFO - Running setup.py (path:/tmp/pip-fP5Scm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:49 INFO - Running setup.py (path:/tmp/pip-ADN9RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:50 INFO - Running setup.py (path:/tmp/pip-r5qQ_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:50 INFO - Running setup.py (path:/tmp/pip-Z08wif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:50 INFO - Running setup.py (path:/tmp/pip-WeC5Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:50 INFO - Running setup.py (path:/tmp/pip-N9mzas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:50 INFO - Running setup.py (path:/tmp/pip-pxGSGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:50 INFO - Running setup.py (path:/tmp/pip-KazWJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:50 INFO - Running setup.py (path:/tmp/pip-PVT_cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:50 INFO - Running setup.py install for manifestparser 15:52:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:50 INFO - Running setup.py install for mozcrash 15:52:50 INFO - Running setup.py install for mozdebug 15:52:50 INFO - Running setup.py install for mozdevice 15:52:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:50 INFO - Running setup.py install for mozfile 15:52:51 INFO - Running setup.py install for mozhttpd 15:52:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Running setup.py install for mozinfo 15:52:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Running setup.py install for mozInstall 15:52:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Running setup.py install for mozleak 15:52:51 INFO - Running setup.py install for mozlog 15:52:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Running setup.py install for moznetwork 15:52:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Running setup.py install for mozprocess 15:52:51 INFO - Running setup.py install for mozprofile 15:52:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:51 INFO - Running setup.py install for mozrunner 15:52:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:52 INFO - Running setup.py install for mozscreenshot 15:52:52 INFO - Running setup.py install for moztest 15:52:52 INFO - Running setup.py install for mozversion 15:52:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:52 INFO - Cleaning up... 15:52:52 INFO - Return code: 0 15:52:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:52 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 0x7f3f1e76df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:52:52 INFO - Using env: {'DISPLAY': ':0', 15:52:52 INFO - 'HOME': '/home/cltbld', 15:52:52 INFO - 'LANG': 'en_US.UTF-8', 15:52:52 INFO - 'LANGUAGE': 'en_US:en', 15:52:52 INFO - 'LOGNAME': 'cltbld', 15:52:52 INFO - 'MAIL': '/var/mail/cltbld', 15:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:52 INFO - 'MOZ_NO_REMOTE': '1', 15:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:52 INFO - 'NO_EM_RESTART': '1', 15:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:52 INFO - 'PWD': '/builds/slave/test', 15:52:52 INFO - 'SHELL': '/bin/bash', 15:52:52 INFO - 'SHLVL': '1', 15:52:52 INFO - 'TERM': 'linux', 15:52:52 INFO - 'TMOUT': '86400', 15:52:52 INFO - 'USER': 'cltbld', 15:52:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:52 INFO - '_': '/tools/buildbot/bin/python'} 15:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:52 INFO - Running setup.py (path:/tmp/pip-zUaKuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:52 INFO - Running setup.py (path:/tmp/pip-sKGFik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:52 INFO - Running setup.py (path:/tmp/pip-3IxQa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:52 INFO - Running setup.py (path:/tmp/pip-ggGOV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:52 INFO - Running setup.py (path:/tmp/pip-DyM7zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:52 INFO - Running setup.py (path:/tmp/pip-OuVrnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:52 INFO - Running setup.py (path:/tmp/pip-5TJhWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:53 INFO - Running setup.py (path:/tmp/pip-2rUxIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:53 INFO - Running setup.py (path:/tmp/pip-kyOp77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:53 INFO - Running setup.py (path:/tmp/pip-C6oQ5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:53 INFO - Running setup.py (path:/tmp/pip-3RRTkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:53 INFO - Running setup.py (path:/tmp/pip-DL5lXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:53 INFO - Running setup.py (path:/tmp/pip-mdgNUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:53 INFO - Running setup.py (path:/tmp/pip-G9vCsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:53 INFO - Running setup.py (path:/tmp/pip-elbVgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:53 INFO - Running setup.py (path:/tmp/pip-I713M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:53 INFO - Running setup.py (path:/tmp/pip-v295zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:52:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:55 INFO - Downloading blessings-1.6.tar.gz 15:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:55 INFO - Installing collected packages: blessings 15:52:55 INFO - Running setup.py install for blessings 15:52:55 INFO - Successfully installed blessings 15:52:55 INFO - Cleaning up... 15:52:55 INFO - Return code: 0 15:52:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:56 INFO - Reading from file tmpfile_stdout 15:52:56 INFO - Current package versions: 15:52:56 INFO - argparse == 1.2.1 15:52:56 INFO - blessings == 1.6 15:52:56 INFO - blobuploader == 1.2.4 15:52:56 INFO - docopt == 0.6.1 15:52:56 INFO - manifestparser == 1.1 15:52:56 INFO - mozInstall == 1.12 15:52:56 INFO - mozcrash == 0.17 15:52:56 INFO - mozdebug == 0.1 15:52:56 INFO - mozdevice == 0.48 15:52:56 INFO - mozfile == 1.2 15:52:56 INFO - mozhttpd == 0.7 15:52:56 INFO - mozinfo == 0.9 15:52:56 INFO - mozleak == 0.1 15:52:56 INFO - mozlog == 3.1 15:52:56 INFO - moznetwork == 0.27 15:52:56 INFO - mozprocess == 0.22 15:52:56 INFO - mozprofile == 0.28 15:52:56 INFO - mozrunner == 6.11 15:52:56 INFO - mozscreenshot == 0.1 15:52:56 INFO - mozsystemmonitor == 0.0 15:52:56 INFO - moztest == 0.7 15:52:56 INFO - mozversion == 1.4 15:52:56 INFO - psutil == 3.1.1 15:52:56 INFO - requests == 1.2.3 15:52:56 INFO - wsgiref == 0.1.2 15:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:56 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 0x7f3f1e76df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:52:56 INFO - Using env: {'DISPLAY': ':0', 15:52:56 INFO - 'HOME': '/home/cltbld', 15:52:56 INFO - 'LANG': 'en_US.UTF-8', 15:52:56 INFO - 'LANGUAGE': 'en_US:en', 15:52:56 INFO - 'LOGNAME': 'cltbld', 15:52:56 INFO - 'MAIL': '/var/mail/cltbld', 15:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:56 INFO - 'MOZ_NO_REMOTE': '1', 15:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:56 INFO - 'NO_EM_RESTART': '1', 15:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:56 INFO - 'PWD': '/builds/slave/test', 15:52:56 INFO - 'SHELL': '/bin/bash', 15:52:56 INFO - 'SHLVL': '1', 15:52:56 INFO - 'TERM': 'linux', 15:52:56 INFO - 'TMOUT': '86400', 15:52:56 INFO - 'USER': 'cltbld', 15:52:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:56 INFO - '_': '/tools/buildbot/bin/python'} 15:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:52:56 INFO - Cleaning up... 15:52:56 INFO - Return code: 0 15:52:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:56 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 0x7f3f1e76df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:52:56 INFO - Using env: {'DISPLAY': ':0', 15:52:56 INFO - 'HOME': '/home/cltbld', 15:52:56 INFO - 'LANG': 'en_US.UTF-8', 15:52:56 INFO - 'LANGUAGE': 'en_US:en', 15:52:56 INFO - 'LOGNAME': 'cltbld', 15:52:56 INFO - 'MAIL': '/var/mail/cltbld', 15:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:56 INFO - 'MOZ_NO_REMOTE': '1', 15:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:56 INFO - 'NO_EM_RESTART': '1', 15:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:56 INFO - 'PWD': '/builds/slave/test', 15:52:56 INFO - 'SHELL': '/bin/bash', 15:52:56 INFO - 'SHLVL': '1', 15:52:56 INFO - 'TERM': 'linux', 15:52:56 INFO - 'TMOUT': '86400', 15:52:56 INFO - 'USER': 'cltbld', 15:52:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:56 INFO - '_': '/tools/buildbot/bin/python'} 15:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:56 INFO - Downloading/unpacking jsonschema 15:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:58 INFO - Downloading/unpacking functools32 (from jsonschema) 15:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:58 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:58 INFO - warning: no files found matching '*.txt' 15:52:58 INFO - no previously-included directories found matching 'build' 15:52:58 INFO - no previously-included directories found matching 'dist' 15:52:58 INFO - no previously-included directories found matching '.git*' 15:52:58 INFO - Installing collected packages: jsonschema, functools32 15:52:58 INFO - Running setup.py install for functools32 15:52:58 INFO - warning: no files found matching '*.txt' 15:52:58 INFO - no previously-included directories found matching 'build' 15:52:58 INFO - no previously-included directories found matching 'dist' 15:52:58 INFO - no previously-included directories found matching '.git*' 15:52:58 INFO - Successfully installed jsonschema functools32 15:52:58 INFO - Cleaning up... 15:52:58 INFO - Return code: 0 15:52:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:58 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 0x7f3f1e76df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:52:58 INFO - Using env: {'DISPLAY': ':0', 15:52:58 INFO - 'HOME': '/home/cltbld', 15:52:58 INFO - 'LANG': 'en_US.UTF-8', 15:52:58 INFO - 'LANGUAGE': 'en_US:en', 15:52:58 INFO - 'LOGNAME': 'cltbld', 15:52:58 INFO - 'MAIL': '/var/mail/cltbld', 15:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:58 INFO - 'MOZ_NO_REMOTE': '1', 15:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:58 INFO - 'NO_EM_RESTART': '1', 15:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:58 INFO - 'PWD': '/builds/slave/test', 15:52:58 INFO - 'SHELL': '/bin/bash', 15:52:58 INFO - 'SHLVL': '1', 15:52:58 INFO - 'TERM': 'linux', 15:52:58 INFO - 'TMOUT': '86400', 15:52:58 INFO - 'USER': 'cltbld', 15:52:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:58 INFO - '_': '/tools/buildbot/bin/python'} 15:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:59 INFO - Downloading/unpacking flake8 15:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:53:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:53:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:53:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:01 INFO - no previously-included directories found matching 'docs/_build' 15:53:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:53:01 INFO - Running setup.py install for pep8 15:53:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:01 INFO - no previously-included directories found matching 'docs/_build' 15:53:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:53:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:53:01 INFO - Cleaning up... 15:53:01 INFO - Return code: 0 15:53:01 INFO - Running post-action listener: _resource_record_post_action 15:53:01 INFO - Running post-action listener: _start_resource_monitoring 15:53:01 INFO - Starting resource monitoring. 15:53:01 INFO - ##### 15:53:01 INFO - ##### Running install step. 15:53:01 INFO - ##### 15:53:01 INFO - Running pre-action listener: _resource_record_pre_action 15:53:01 INFO - Running main action method: install 15:53:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:02 INFO - Reading from file tmpfile_stdout 15:53:02 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:02 INFO - Reading from file tmpfile_stdout 15:53:02 INFO - Output received: 15:53:02 INFO - Usage: mozinstall [options] installer 15:53:02 INFO - Options: 15:53:02 INFO - -h, --help show this help message and exit 15:53:02 INFO - -d DEST, --destination=DEST 15:53:02 INFO - Directory to install application into. [default: 15:53:02 INFO - "/builds/slave/test"] 15:53:02 INFO - --app=APP Application being installed. [default: firefox] 15:53:02 INFO - mkdir: /builds/slave/test/build/application 15:53:02 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'] 15:53:02 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 15:53:18 INFO - Reading from file tmpfile_stdout 15:53:18 INFO - Output received: 15:53:18 INFO - /builds/slave/test/build/application/firefox/firefox 15:53:18 INFO - Running post-action listener: _resource_record_post_action 15:53:18 INFO - ##### 15:53:18 INFO - ##### Running run-tests step. 15:53:18 INFO - ##### 15:53:18 INFO - Running pre-action listener: _resource_record_pre_action 15:53:18 INFO - Running main action method: run_tests 15:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:18 INFO - Python 2.7.3 15:53:18 INFO - Return code: 0 15:53:18 INFO - grabbing minidump binary from tooltool 15:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, '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 0x1575310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15757a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:53:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:53:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:18 INFO - Return code: 0 15:53:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:53:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:53:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:53:19 INFO - Return code: 0 15:53:19 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/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:53:19 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/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:53:19 INFO - Using env: {'DISPLAY': ':0', 15:53:19 INFO - 'HOME': '/home/cltbld', 15:53:19 INFO - 'LANG': 'en_US.UTF-8', 15:53:19 INFO - 'LANGUAGE': 'en_US:en', 15:53:19 INFO - 'LOGNAME': 'cltbld', 15:53:19 INFO - 'MAIL': '/var/mail/cltbld', 15:53:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:19 INFO - 'MOZ_NO_REMOTE': '1', 15:53:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:19 INFO - 'NO_EM_RESTART': '1', 15:53:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:19 INFO - 'PWD': '/builds/slave/test', 15:53:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:19 INFO - 'SHELL': '/bin/bash', 15:53:19 INFO - 'SHLVL': '1', 15:53:19 INFO - 'TERM': 'linux', 15:53:19 INFO - 'TMOUT': '86400', 15:53:19 INFO - 'USER': 'cltbld', 15:53:19 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370', 15:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:19 INFO - '_': '/tools/buildbot/bin/python'} 15:53:19 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/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:53:19 INFO - mozversion application_buildid: 20160426142902 15:53:19 INFO - mozversion application_changeset: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 15:53:19 INFO - mozversion application_display_name: Nightly 15:53:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:19 INFO - mozversion application_name: Firefox 15:53:19 INFO - mozversion application_remotingname: firefox 15:53:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:53:19 INFO - mozversion application_vendor: Mozilla 15:53:19 INFO - mozversion application_version: 49.0a1 15:53:19 INFO - mozversion platform_buildid: 20160426142902 15:53:19 INFO - mozversion platform_changeset: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 15:53:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:53:19 INFO - mozversion platform_version: 49.0a1 15:53:19 INFO - using testdate: 1461711199 15:53:19 INFO - actual date: 1461711199 15:53:19 INFO - starting webserver on 'localhost:55465' 15:53:19 INFO - SUITE-START | Running 2 tests 15:53:19 INFO - TEST-START | dromaeo_css 15:53:19 INFO - operating with platform_type : linux_ 15:53:19 INFO - Initialising browser for dromaeo_css test... 15:53:19 INFO - TEST-INFO | started process 16413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO4Fzts/profile http://localhost:55465/getInfo.html) 15:53:24 INFO - PROCESS | 16413 | __metrics Screen width/height:1600/1200 15:53:24 INFO - PROCESS | 16413 | colorDepth:24 15:53:24 INFO - PROCESS | 16413 | Browser inner width/height: 1024/697 15:53:24 INFO - PROCESS | 16413 | __metrics 15:53:25 ERROR - PROCESS | 16413 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:53:25 INFO - TEST-INFO | 16413: exit 0 15:53:25 INFO - Browser initialized. 15:53:25 INFO - Running cycle 1/1 for dromaeo_css test... 15:53:25 INFO - TEST-INFO | started process 16493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO4Fzts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:37 INFO - PROCESS | 16493 | RSS: Main: 156225536 15:53:37 INFO - PROCESS | 16493 | 15:54:28 INFO - PROCESS | 16493 | 1461711268809 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:56:40 INFO - PROCESS | 16493 | Cycle 1(1): loaded http://localhost:55465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55465/tests/dromaeo/cssquery-ext.html) 15:56:41 INFO - PROCESS | 16493 | RSS: Main: 245731328 15:56:41 INFO - PROCESS | 16493 | 15:59:44 INFO - PROCESS | 16493 | Cycle 1(1): loaded http://localhost:55465/tests/dromaeo/cssquery-ext.html (next: http://localhost:55465/tests/dromaeo/cssquery-jquery.html) 15:59:44 INFO - PROCESS | 16493 | RSS: Main: 235532288 15:59:44 INFO - PROCESS | 16493 | 16:02:46 INFO - PROCESS | 16493 | Cycle 1(1): loaded http://localhost:55465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55465/tests/dromaeo/cssquery-mootools.html) 16:02:47 INFO - PROCESS | 16493 | RSS: Main: 244305920 16:02:47 INFO - PROCESS | 16493 | 16:05:49 INFO - PROCESS | 16493 | Cycle 1(1): loaded http://localhost:55465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55465/tests/dromaeo/cssquery-prototype.html) 16:05:50 INFO - PROCESS | 16493 | RSS: Main: 235171840 16:05:50 INFO - PROCESS | 16493 | 16:08:53 INFO - PROCESS | 16493 | Cycle 1(1): loaded http://localhost:55465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55465/tests/dromaeo/cssquery-yui.html) 16:08:53 INFO - PROCESS | 16493 | RSS: Main: 212783104 16:08:53 INFO - PROCESS | 16493 | 16:11:56 INFO - PROCESS | 16493 | Cycle 1(1): loaded http://localhost:55465/tests/dromaeo/cssquery-yui.html (next: http://localhost:55465/tests/dromaeo/cssquery-dojo.html) 16:11:57 INFO - PROCESS | 16493 | RSS: Main: 279543808 16:11:57 INFO - PROCESS | 16493 | 16:11:57 INFO - PROCESS | 16493 | __start_tp_report 16:11:57 INFO - PROCESS | 16493 | _x_x_mozilla_page_load 16:11:57 INFO - PROCESS | 16493 | _x_x_mozilla_page_load_details 16:11:57 INFO - PROCESS | 16493 | |i|pagename|runs| 16:11:57 INFO - PROCESS | 16493 | |0;dojo.html;2651.5359812032893;2687.6102965070054;2721.3740839606876;2728.9999999999995;2737.1104391072904;4517.503074661785;4638.420197475316;4667.649926255532;4677.95322046779;4729.2433210686295;4602.723836569809;4649.651276154294;4650.581447669709;4653.232216684243;4655.278431843061;4215.473065866767;4298.376735373369;4313.309870420718;4363.0619416825375;4415.161119387322;4303.483581970168;4379.386885835986;4395.824167033315;4401.031773009932;4428.822847086129;4224.134052519226;4298.183345164409;4307.181635489247;4312.094460163369;4318.050028993616;4261.637760790337;4261.978690106561;4264.87205383839;4266.786660666954;4270.402143699885;4238.17355615652;4240.851570195028;4242.639375653073;4243.724157929724;4254.829806807724;4521.819127234907;4550.977245113786;4577.244754615484;4588.632909367243;4602;4938.925916111261;4960.33035540201;4966.230234313651;4970.229614409773;5011.599072074226;4844.854654360375;4981.900361992776;4984.077945580079;4996.075725990703;5001.349824522788;4671.205894997858;4672.789724462339;4688.2733176357715;4711.764411779397;4724;5090.796368145233;5095.821646242438;5101.081805275012;5121.897562048738;5173.224016397495;4802.063597598435;4906.779194936236;4911.9754401227765;4953.157963146274;4959.479254678279;4971.850844474671;4987.301777751118;4998.125328067574;5000.849974500771;5032.446430892599;4913.238448040559;4955.331030310934;4962.826301079445;4969.900601988013;4997.675151115166;4833.975830120827;4889.779959901813;4977.850664480072;4985.601151907838;4988.575971042429;4186.91626167475;4199.601037901394;4210.410542524049;4217.683673724483;4233.216854881856;3715.3498137825773;3716.8141592920247;3735.4957080793747;3736.3834967230646;3757;4256.638185754246;4304.461942257218;4329.350597410414;4385.890352741143;4389.144116897174;5022.096022715873;5034.270030845581;5036.974815125901;5042.445331013586;5070.6957582545165;4292.077203401283;4340.088581397878;4345.239583072949;4365.454318210223;4394.560543945579;4390.692651514363;4486.192485352668;4523.547645235516;4535.909281814345;4564.041551274203;4711.057788442326;4724.858254252446;4734.85795426124;4736.763161841963;4783.928241076456;4884.169691152583;5001.049800537886;5019.171836646912;5026.220935754964;5073.670211436245;4754.21555443348;4773.522647735199;4793.257045158006;4810.927836082392;4835.178019736582;4896.461389247109;4934.901301974012;4935.506449355035;4942.20924652054;4990.700557966534;4855.320255164351;4976.328195693535;4992.026554821775;4995.275685025578;5056.266841308064;4852.878678033077;4855.562999330077;4873.488283730299;4883;4924.064427758714;4847.587955023862;4873.147199240189;4877.146499362669;4881.048195601824;4916.311716359784;4693.530646935279;4754;4811.591014763644;4845.5881250094135;4850.005748821412;4866.80532778699;4890.388701412324;4905.117078925828;4926.064047830901;4953.950460495349;4798.976005119952;4802.039592081667;4803.687760295569;4804.2073057945045;4847.321375007572 16:11:57 INFO - PROCESS | 16493 | |1;ext.html;577.4110407384468;606.3027518353894;614.5943677173067;624.0981781325983;669.4343279928462;27573.58639620405;32272.677273227262;33068.33863322735;33085.5037174442;33093.00720978375;36478;36997.26005479889;37120.25759484809;37191.814040929756;37199.070023249435;7417.369523590488;7668.884966725504;7669.309762121408;7669.769906902802;7673.769786906401;7539.283768042054;7691.730789422371;7699.961500192519;7701.037370328709;7701.268379503967;7540.8114797129965;7585.7344992925255;7588;7588.430867684918;7588.468807183499;7619.542827430372;7702.730404435818;7703;7705.075390953093;7707.229277072276;7524.661390237453;7634.389248860133;7638.083429988382;7641.3122818946;7644.350230230437;33951.15122121942;34517.13707157316;34567.58026938116;34576.82711586426;34644.48033279503;3091.9690803091908;3168.6989735975044;3217.4208642444582;3497.4928635347733;3727.4222495512968;26436;26543.734562654514;26990.865045674844;27037.864810676016;27106.45787084267;3293.1602441377295;3313.96686033139;3483.756137070406;3493.2489514754448;3534.240138370237;177182;177440;177713;177827;177979;45995.77002115035;46681.5331846684;46945.53054469411;46950.295745563846;46996.7650161747;49464;49623.25565116526;49847;49852.50147498551;50001;12845.614631561068;12988.415521301375;12997.15518491295;13026.2835544046;13031;9660.227181825438;9660.613575456902;9660.806783864284;9689.563969621244;9695.321327507148;13990.30048497571;14721.779173312409;14728.337224824694;14821.40714371413;14994.175320357484;4966.1061009018;5785.566082543742;5840.766369345263;5977.312609049928;6030.884286407028;897.6050537763364;931.6878845586668;971.9125278724948;979.7452662307851;1007.9949600251952;24564.97344205859;25461.61807572888;26178.738212618013;26585.867070664524;27052.188434347;951.1059603972244;952.8142012307673;954.9809003819885;958.7171784323641;1010.3533738407425;13209.537666181637;13826.239556824472;13991.790123148161;14060.648483787783;14136.363863625957;252788;255388;256182;256291;256686;42104.1579168421;42387.364189537184;42476.15047699029;42478.1504369917;42511.787441063214;1076.5962763963514;1135.4663308245113;1153.4982282707049;1208.975820483603;1249.5376710616947;24312;25761.871190643928;26222.73777262203;26259.343516411478;26742.59886101671;35453.645463545035;35793.64206357903;36089.27821443609;36097.81951090228;36138.45792313065;171727;172355;172393;173355;173977;19915.800841991975;22016.229431970445;22449.10203591838;22461;23297.301080967598;33608.83195584006;33631.327373452885;33791.3241735159;34675.826620866734;34893.825530872185;31043.68956310408;31047.844760776956;32079.754417190572;32599.837000814845;33003.66996330102;28982.972528482565;29654.40691186121;29823;30478.542821857245;31039.53440698346;32410.189745256557;32851.835740821145;33070.83464582662;33114.83442582868;33132.83433582816;29168.27079323034;29573.26066848346;29620.407591848474;29975.45208657201;29997;22977.310680679606;22982.885085575133;23361.766382335958;23508.529829402974;23606.881965590062 16:11:57 INFO - PROCESS | 16493 | |2;jquery.html;370.1135779807361;382.26986455869286;385.91316953685407;386.5709062940134;389.81678611052797;15060.472883449082;15712.764308535367;16290.51128466145;16438;16475.17624118794;12769.23384596925;14440.350184241708;14451;14469.493567725132;14470.987030907814;3869.922601547967;4779.713217206961;4786.4974177711365;4787.54518320759;4799.280107983813;4538.523455037207;4734.26618874075;4737.928931066037;4738.407699037621;4739.52604739525;4726.243800991842;5032.270320803481;5329.706866122362;5337.67973921564;5343.225232341309;5263.236830659552;5274.235235890794;5274.578033757329;5278.076336641092;5284.180951952453;4924.3105965164905;5263.973680131613;5276.182191760283;5277.577793776489;5294.100002999499;18310.26758929641;18557.257709691596;18950.81049189518;19111.331103411452;19146.521336966547;1861.4322631597358;1949.5710943592387;2198.2855571939185;2269.6482045283005;2434.732179460258;8669.609867555975;8675.349348798802;8893.510856902867;8961.193492585633;9296.30277729173;1666.2585149608428;1708.9914550427293;1738.3741852932933;1774.0065563284602;1805.4673871208024;55532;56177.71911140459;56970.430295696926;57615.711921440125;58339.708301458224;9836.606535738634;9916.405015699082;9984.251181161442;9994.200463962865;10152.847707284396;13585.184888906697;13670.863291366959;13676.589702308947;13725.794113088312;13727.931360343135;6806.931930680729;6811.352921472452;6849.589024658537;7020.7893763187185;7034.085568876013;6461.7738379157445;6555.770548030796;6627.867442651216;6628.270890202074;6661.233958094785;4316.374125751749;4410.871058105131;4419.668524860648;4462.799174037176;4529.365888775574;1842.54857559896;1855.4062699935891;1873.6721073812027;1911.8168249864098;1932.7970563090673;771.6527562596854;821.0639870547581;948.4262021477045;951.871497347863;989.9505024748734;15658;15974.520764377086;16065;16112.436064737678;16620.418285359956;848.7114381110329;869.1135042256863;877.5480627476854;912.8767616371838;920.1810388754014;9039.276857851357;9089.31830112731;9340.392874463138;9446.811063778687;9608.375455595364;367352;372546;381488;386335;392644;62033;63356.36643633597;63806;64714.67642661757;64956.35043649597;904.5341649050744;909.4225167018991;931.8415869302235;934.780326623243;937.95310234488;11243.325400475998;14273.214973176575;14495.912806539342;14519.78220326717;14700.77948830747;28559.42881142324;29448.852755736083;30217.697823021488;31926.52110218395;32019.758616896594;41723.1655366897;42101.36847947344;42380.36429453499;42536.36195457132;42697.57302426936;7592.658330375036;7652;7732.188120247293;7822.960885195537;7862;10195.949020254851;11248.381339026431;11331.660050198507;11507.424628768695;11527.250728702607;10049.598016079275;10093.798124037625;10201.642942496977;10231.079202871777;10483.266171367932;9803.460809655537;9808.313418060667;10249.231307651808;10250.641227557298;10297;9921.503924803586;10065.446400448045;10135.442550659489;10434.895521195376;10499.842502362319;7580.696772129053;7761.185075566984;7860.3318717909615;7878.409119315959;7915.722949696733;8987.595558200028;9926.15627671656;10088.344257623232;10278.691639250834;10648.574057037631 16:11:57 INFO - PROCESS | 16493 | |3;mootools.html;1219.9817002744956;1420.4531255466645;1426.5720283914825;1551.7362048451762;1716.3821024431195;6434.6139231646075;7362.153352364473;7576.886346704804;7594.088709354885;7599.810004749884;7379.926200737991;7543.924560754391;7560.848783024337;7565;7567.886481702779;1877.2491003598534;2174.6737989301614;2181.9454513637206;2207.0619986505753;2260.1298500077505;2223.399682085836;2251.6622506624058;2252.909883604662;2255.4248666589997;2258.706368172135;2134.391698365966;2135.1459416233474;2185.4317877351923;2200.482886521666;2203.5703037907615;1821.4444594398703;2106.494441334084;2146.527763891941;2164.729408823897;2167.924122655715;2134.1463414634113;2136.925207617726;2154.859934104278;2159.3306075116766;2159.730033745782;7184.209736928934;7230;7266.927330726678;7267.600281984489;7295.562266264041;4240.23675738367;4429.82609608454;4433.645308375322;4439.200943830109;4439.489458712257;2886.5381538953875;2895.363020135567;2915.6355455568055;2918.8394638294885;2968.2876109733725;834.9248567628882;850.59596691571;888.1118881118881;896.7130518234168;913.8492148795507;10240.027197416308;10266.794664106676;10292.330998485075;10315.896841031568;10317.484125793755;4217.97891010543;4282.143571285756;4319.654427645781;4371;4376.7811609419405;8798.780030499289;8808.779780505538;8809.07504711996;8858.911410885808;8884.244839188612;4499.505054444008;4537.0925814837165;4541.205289074464;4541.409616749867;4541.841035563805;3670.4310831821113;4051.493563304587;4169.395437661522;4175.54069052404;4175.895602609899;3470.583529976419;3543.1319326765106;3582.9283414331567;3608.87368942091;3649.9270014600093;1193.2244041373176;1193.3257709394165;1196.186593116689;1196.904247660185;1198.9460474278503;699.6431819771851;874.9387542871938;878.5299864572423;891.7948871759531;897.1297841094129;5258.342707161605;5430.321209848769;5453.863653408696;5512.118061110284;5524.944750552523;407.56390661991975;410.38852110355356;415.77963679250047;417.17815902671686;418.6483353982608;3734.3651579231596;3819.1597848473293;3820.56063552695;3846.8845934622004;3879.2435475082652;9189.494577798285;9543.522823858779;9574.569144388519;9646.614135434644;9668.951655241819;9468.384555003902;9542.379745316532;9546.90453095474;9552.37909535878;9567.425954442755;7217;7320.633968301564;7378.262173782686;7404.296591823768;7424.888626670604;5309;5349.117395629678;5355.919661205007;5584.525315348241;5592.245046918777;8219.630116644885;8461.40770146084;8492.490450572985;8594.226519613265;8598.828023439371;8502.659893604186;8581.485110893367;8918.86621700688;8924.776880578038;9047.276217902683;5963;6573.868522629617;6649.368310010541;6749.898751518829;6834.350736680008;7343.559386436831;7369.77890663281;7428.368588669808;7448.851022979402;7449.4412919032375;6605;6704.363085506869;6752.729890804313;6863.759768408082;6872.41584465326;6670.499712521678;6685.732570697312;6695.4978376620975;6746.662666866735;6830.077939478107;6370.90443643355;6440.645764482999;6517.869642607026;6526.314736952551;6527.445167160845;4649.1863923812525;4726.93483604107;4823.758812059453;4866.878328041686;4872.342233798392;4545.840895568639;4548.47692515365;4582.450105987303;4591.678582499193;4733.982193828343 16:11:57 INFO - PROCESS | 16493 | |4;prototype.html;298.7042827600676;300.0338908713941;302.6625312776254;302.83192827980474;306.26038117945166;4645.9070818583605;4713.0573885223;4717.268823332389;4748.768079002872;4776;4654.44076234461;4674.228752255874;4685.3835426777705;4695.71825690458;4707.176244157267;3494.1264683829045;3575.8748443804343;3620.81895905205;3718.7210959178033;3734.906627334311;3697.611750766171;3726.142987112966;3736.2901048800777;3743.644353786386;3751.4747935289083;3514.523899962009;3697.6318762058077;3699.1122130688577;3708.5364329458816;3733.701303895682;3525.823708814549;3731.7760934343755;3745.662890339855;3746.194568167857;3761;3323.88366407177;3331;3332.8833490827706;3334.499825026241;3340.1315657929113;4513.435820522434;4518.638508919278;4544;4570.702904311209;4572.611328037121;3926.4110383442426;4195.7063005589625;4202.327627579572;4211.094614657833;4234.724742891703;4870.342503762017;4910.508949105097;4914.508549145093;4926.064047830901;4931.334269873557;3477.80015894516;3484.8083355415442;3496.6328535503912;3498.8425520851624;3503.5795704515367;4958.2562615607585;4991.101601711727;5027.874303142414;5127.589792816566;5145.25393817898;3487.337405892872;3502.387082260594;3526.20660351424;3528.835484290178;3535.52270443492;3539.681428671432;3547.8935631931085;3557.964420355815;3569.607343192247;3594.8741794037082;4061.918761624751;4081.510218773766;4082.9581961438325;4120.690948178899;4133.297339452301;4749.976250118727;4914.926276105862;4915.65590408668;4921.769557610597;4937.086638971802;1306.9346532673328;1315.4869600855675;1317.6771690935782;1318.6439661291397;1323.5169163255343;824.4435006370676;862.2326129744532;876.3252295732251;894.3560636341823;897.9102089790969;4602.286645569942;4619.145458090264;4620.607248383858;4641.466231383367;4653.348531205634;5333.333333333333;5344.465553444625;5346.117890548016;5346.4118946915805;5359.159645387951;4496.19068567661;4593.425821772278;4609.400777898852;4628.097520983376;4657.6273898088075;2823.84468854215;2853.985730071378;2857.5427931530853;2859.556768700813;2869.497837878405;5010.323606313101;5029.723365214875;5043.697378157322;5043.798248070109;5045.899082018339;5230.895382092413;5433.755481003364;5439.211314359396;5458.235846981426;5476.534494568006;5009.24861270805;5023.598112151019;5031.748412579356;5048.141815891381;5054.545090941833;5326.3874654413685;5329.54698850602;5342.732863356739;5358.437364076716;5378.731063446734;4730.1958667027375;5060.949390506048;5063.3417655704525;5068.847934561822;5077.949220507748;4805.6155507558615;4842.4189097308545;4858.951410485991;4875.414950205998;4875.6099512038245;3581.997040828572;3591.389463791214;3612.692921101736;3614.403623402109;3627.4558816177782;4815.686980346266;5111.897762044812;5118.616103792305;5133.666311689728;5153.3558305211845;4939.43196532389;4966.751662416937;4975.228839529878;4986;5001.374828146481;4917.754112294299;4973.751312434291;4976.751162441936;4987.551120399182;4998.1503144464805;4622.722636641813;4792.448868380181;4885.851824821235;4891.31521586971;4919.434265059421;4811.171754733319;4961.231009193581;4976.477469865757;4996.750162491788;5001.199808030698;4832.178529650038;4857;4872.853814385574;4880.92678609814;4884.877878053077 16:11:57 INFO - PROCESS | 16493 | |5;yui.html;627.7740013595105;692.3595674001548;752.9308382097423;756.9091708994921;781.8944442500265;11851.22967007144;12217.328046957426;12315.63053108407;12346.62960111196;12429.937850310747;11373.488193031313;11379.829302560469;11389.886101138985;11390.259633123842;11510.251833630808;636.6880228687955;774.5468900693102;786.4494853602473;804;807.4953154278576;794.0986979777936;800.3077338102529;801.6472751989136;802.3741481644298;803.0724513187278;840.357126798;846.5894041389921;847.2501835875233;847.6397531049311;847.771101802516;662.327737346596;815.4495715392087;835.7826964989085;849.5837039850429;850.090403268503;601.2004034633926;605.1255935173676;611.037615755183;611.3825036712952;611.5871786544064;11389.259698119678;11454.255473394203;11468.19722619417;11472.598459053977;11493.885061149365;10548;11401.501144347725;11510.539578416854;11844;11942.402879855972;11155.219134660578;11226.550937962471;11304.434778261055;11371.147163962736;11411.372374519398;4129.876103716893;4174.457320548339;4226.260404429213;4226.767527785971;4395.582419670126;42964.355534667004;43197.35203971943;43215.35176972348;43310.78344608288;43485;9756.707298781048;9773.853392199122;9908.653197138066;9912.950435247922;10178.745531361776;17734.20196091153;17945;17975;17983.910080449514;18042.63914721698;6434.485241180694;6899.48253880961;6942.548734332252;7003.859922801617;7046.964765176142;3622.909427264287;3689.575698794673;3700.3524383232825;3705;3731.067233191702;2767.79241556884;2845.4593627210766;2846.6868644449096;2847.0889315418867;2849.9145025649264;526.7050451747034;536.2198001907216;538.2383926743693;539.8596364945064;542.8859939412689;586.5542187937199;637.85648229149;648.1250312078656;661.4509956735898;672.8957011663102;8043.130552635031;8089;8121.837563248702;8197.672093116327;8245.79385515355;466.8249406472573;503.46129641284205;505.919052951526;572.221778381401;578.6383510306059;3863.439801228806;3885.65389063934;3940.6650434712797;4018.1160144768687;4054.3715724062818;49992;52058.21912671313;52253;52396.47603523916;52450.737746311024;46799.76600116977;47249;47464.52535474601;48793;49146.508534914195;43712.56287437085;44491;44498;44921.326180107324;45409.77295113503;7649.61751912391;8023.919760802551;8369.238151410142;8446.915530844613;8634.136586341567;29813.254668633457;29944.25139371533;30002.399952001273;30020.2036208066;30068.849655751583;36894.262114758094;39932.40101398539;40646.59353406428;41274.79362603168;41903.1619367617;9898.851517227391;9936.950315248378;10220.131288840532;10258.43578603184;10935.507902144582;11776.646700598996;12214.450349734461;12292.262464252173;12330.75338493243;12335.198212116184;10662.306950048533;10777.461126943464;10918;11007.174461915549;11272.605458808903;11140;11704.180707350744;11747.530098795953;11755.294682319089;11827.822582661094;11153.442327883411;11181.832272515756;11538;11719.238249513754;11775.941120294343;9498.287628428034;9548.665796697082;9739.513024348613;10320.948395257976;10406.219533535166;9096.818063638822;9249.445033298023;9275.443473391619;9335.673251436167;9381.249500040118 16:11:57 INFO - PROCESS | 16493 | __end_tp_report 16:11:57 INFO - PROCESS | 16493 | __start_cc_report 16:11:57 INFO - PROCESS | 16493 | _x_x_mozilla_cycle_collect,894 16:11:57 INFO - PROCESS | 16493 | __end_cc_report 16:11:57 INFO - PROCESS | 16493 | __startTimestamp1461712317092__endTimestamp 16:11:57 INFO - PROCESS | 16493 | 16:11:57 INFO - PROCESS | 16493 | ------- Summary: start ------- 16:11:57 INFO - PROCESS | 16493 | Number of tests: 6 16:11:57 INFO - PROCESS | 16493 | 16:11:57 INFO - PROCESS | 16493 | [#0] dojo.html Cycles:165 Average:4620.78 Median:4773.52 stddev:467.86 (9.8%) stddev-sans-first:443.06 16:11:57 INFO - PROCESS | 16493 | Values: 2651.5 2687.6 2721.4 2729.0 2737.1 4517.5 4638.4 4667.6 4678.0 4729.2 4602.7 4649.7 4650.6 4653.2 4655.3 4215.5 4298.4 4313.3 4363.1 4415.2 4303.5 4379.4 4395.8 4401.0 4428.8 4224.1 4298.2 4307.2 4312.1 4318.1 4261.6 4262.0 4264.9 4266.8 4270.4 4238.2 4240.9 4242.6 4243.7 4254.8 4521.8 4551.0 4577.2 4588.6 4602.0 4938.9 4960.3 4966.2 4970.2 5011.6 4844.9 4981.9 4984.1 4996.1 5001.3 4671.2 4672.8 4688.3 4711.8 4724.0 5090.8 5095.8 5101.1 5121.9 5173.2 4802.1 4906.8 4912.0 4953.2 4959.5 4971.9 4987.3 4998.1 5000.8 5032.4 4913.2 4955.3 4962.8 4969.9 4997.7 4834.0 4889.8 4977.9 4985.6 4988.6 4186.9 4199.6 4210.4 4217.7 4233.2 3715.3 3716.8 3735.5 3736.4 3757.0 4256.6 4304.5 4329.4 4385.9 4389.1 5022.1 5034.3 5037.0 5042.4 5070.7 4292.1 4340.1 4345.2 4365.5 4394.6 4390.7 4486.2 4523.5 4535.9 4564.0 4711.1 4724.9 4734.9 4736.8 4783.9 4884.2 5001.0 5019.2 5026.2 5073.7 4754.2 4773.5 4793.3 4810.9 4835.2 4896.5 4934.9 4935.5 4942.2 4990.7 4855.3 4976.3 4992.0 4995.3 5056.3 4852.9 4855.6 4873.5 4883.0 4924.1 4847.6 4873.1 4877.1 4881.0 4916.3 4693.5 4754.0 4811.6 4845.6 4850.0 4866.8 4890.4 4905.1 4926.1 4954.0 4799.0 4802.0 4803.7 4804.2 4847.3 16:11:57 INFO - PROCESS | 16493 | 16:11:57 INFO - PROCESS | 16493 | [#1] ext.html Cycles:180 Average:35334.14 Median:18223.40 stddev:53429.58 (293.2%) stddev-sans-first:53515.73 16:11:57 INFO - PROCESS | 16493 | Values: 577.4 606.3 614.6 624.1 669.4 27573.6 32272.7 33068.3 33085.5 33093.0 36478.0 36997.3 37120.3 37191.8 37199.1 7417.4 7668.9 7669.3 7669.8 7673.8 7539.3 7691.7 7700.0 7701.0 7701.3 7540.8 7585.7 7588.0 7588.4 7588.5 7619.5 7702.7 7703.0 7705.1 7707.2 7524.7 7634.4 7638.1 7641.3 7644.4 33951.2 34517.1 34567.6 34576.8 34644.5 3092.0 3168.7 3217.4 3497.5 3727.4 26436.0 26543.7 26990.9 27037.9 27106.5 3293.2 3314.0 3483.8 3493.2 3534.2 177182.0 177440.0 177713.0 177827.0 177979.0 45995.8 46681.5 46945.5 46950.3 46996.8 49464.0 49623.3 49847.0 49852.5 50001.0 12845.6 12988.4 12997.2 13026.3 13031.0 9660.2 9660.6 9660.8 9689.6 9695.3 13990.3 14721.8 14728.3 14821.4 14994.2 4966.1 5785.6 5840.8 5977.3 6030.9 897.6 931.7 971.9 979.7 1008.0 24565.0 25461.6 26178.7 26585.9 27052.2 951.1 952.8 955.0 958.7 1010.4 13209.5 13826.2 13991.8 14060.6 14136.4 252788.0 255388.0 256182.0 256291.0 256686.0 42104.2 42387.4 42476.2 42478.2 42511.8 1076.6 1135.5 1153.5 1209.0 1249.5 24312.0 25761.9 26222.7 26259.3 26742.6 35453.6 35793.6 36089.3 36097.8 36138.5 171727.0 172355.0 172393.0 173355.0 173977.0 19915.8 22016.2 22449.1 22461.0 23297.3 33608.8 33631.3 33791.3 34675.8 34893.8 31043.7 31047.8 32079.8 32599.8 33003.7 28983.0 29654.4 29823.0 30478.5 31039.5 32410.2 32851.8 33070.8 33114.8 33132.8 29168.3 29573.3 29620.4 29975.5 29997.0 22977.3 22982.9 23361.8 23508.5 23606.9 16:11:57 INFO - PROCESS | 16493 | 16:11:57 INFO - PROCESS | 16493 | [#2] jquery.html Cycles:180 Average:22586.47 Median:4496.08 stddev:62270.85 (1385.0%) stddev-sans-first:62423.19 16:11:57 INFO - PROCESS | 16493 | Values: 370.1 382.3 385.9 386.6 389.8 15060.5 15712.8 16290.5 16438.0 16475.2 12769.2 14440.4 14451.0 14469.5 14471.0 3869.9 4779.7 4786.5 4787.5 4799.3 4538.5 4734.3 4737.9 4738.4 4739.5 4726.2 5032.3 5329.7 5337.7 5343.2 5263.2 5274.2 5274.6 5278.1 5284.2 4924.3 5264.0 5276.2 5277.6 5294.1 18310.3 18557.3 18950.8 19111.3 19146.5 1861.4 1949.6 2198.3 2269.6 2434.7 8669.6 8675.3 8893.5 8961.2 9296.3 1666.3 1709.0 1738.4 1774.0 1805.5 55532.0 56177.7 56970.4 57615.7 58339.7 9836.6 9916.4 9984.3 9994.2 10152.8 13585.2 13670.9 13676.6 13725.8 13727.9 6806.9 6811.4 6849.6 7020.8 7034.1 6461.8 6555.8 6627.9 6628.3 6661.2 4316.4 4410.9 4419.7 4462.8 4529.4 1842.5 1855.4 1873.7 1911.8 1932.8 771.7 821.1 948.4 951.9 990.0 15658.0 15974.5 16065.0 16112.4 16620.4 848.7 869.1 877.5 912.9 920.2 9039.3 9089.3 9340.4 9446.8 9608.4 367352.0 372546.0 381488.0 386335.0 392644.0 62033.0 63356.4 63806.0 64714.7 64956.4 904.5 909.4 931.8 934.8 938.0 11243.3 14273.2 14495.9 14519.8 14700.8 28559.4 29448.9 30217.7 31926.5 32019.8 41723.2 42101.4 42380.4 42536.4 42697.6 7592.7 7652.0 7732.2 7823.0 7862.0 10195.9 11248.4 11331.7 11507.4 11527.3 10049.6 10093.8 10201.6 10231.1 10483.3 9803.5 9808.3 10249.2 10250.6 10297.0 9921.5 10065.4 10135.4 10434.9 10499.8 7580.7 7761.2 7860.3 7878.4 7915.7 8987.6 9926.2 10088.3 10278.7 10648.6 16:11:57 INFO - PROCESS | 16493 | 16:11:57 INFO - PROCESS | 16493 | [#3] mootools.html Cycles:180 Average:5062.77 Median:5283.67 stddev:2808.04 (53.1%) stddev-sans-first:2801.07 16:11:57 INFO - PROCESS | 16493 | Values: 1220.0 1420.5 1426.6 1551.7 1716.4 6434.6 7362.2 7576.9 7594.1 7599.8 7379.9 7543.9 7560.8 7565.0 7567.9 1877.2 2174.7 2181.9 2207.1 2260.1 2223.4 2251.7 2252.9 2255.4 2258.7 2134.4 2135.1 2185.4 2200.5 2203.6 1821.4 2106.5 2146.5 2164.7 2167.9 2134.1 2136.9 2154.9 2159.3 2159.7 7184.2 7230.0 7266.9 7267.6 7295.6 4240.2 4429.8 4433.6 4439.2 4439.5 2886.5 2895.4 2915.6 2918.8 2968.3 834.9 850.6 888.1 896.7 913.8 10240.0 10266.8 10292.3 10315.9 10317.5 4218.0 4282.1 4319.7 4371.0 4376.8 8798.8 8808.8 8809.1 8858.9 8884.2 4499.5 4537.1 4541.2 4541.4 4541.8 3670.4 4051.5 4169.4 4175.5 4175.9 3470.6 3543.1 3582.9 3608.9 3649.9 1193.2 1193.3 1196.2 1196.9 1198.9 699.6 874.9 878.5 891.8 897.1 5258.3 5430.3 5453.9 5512.1 5524.9 407.6 410.4 415.8 417.2 418.6 3734.4 3819.2 3820.6 3846.9 3879.2 9189.5 9543.5 9574.6 9646.6 9669.0 9468.4 9542.4 9546.9 9552.4 9567.4 7217.0 7320.6 7378.3 7404.3 7424.9 5309.0 5349.1 5355.9 5584.5 5592.2 8219.6 8461.4 8492.5 8594.2 8598.8 8502.7 8581.5 8918.9 8924.8 9047.3 5963.0 6573.9 6649.4 6749.9 6834.4 7343.6 7369.8 7428.4 7448.9 7449.4 6605.0 6704.4 6752.7 6863.8 6872.4 6670.5 6685.7 6695.5 6746.7 6830.1 6370.9 6440.6 6517.9 6526.3 6527.4 4649.2 4726.9 4823.8 4866.9 4872.3 4545.8 4548.5 4582.5 4591.7 4734.0 16:11:57 INFO - PROCESS | 16493 | 16:11:57 INFO - PROCESS | 16493 | [#4] prototype.html Cycles:180 Average:4153.43 Median:4701.45 stddev:1211.63 (25.8%) stddev-sans-first:1179.98 16:11:57 INFO - PROCESS | 16493 | Values: 298.7 300.0 302.7 302.8 306.3 4645.9 4713.1 4717.3 4748.8 4776.0 4654.4 4674.2 4685.4 4695.7 4707.2 3494.1 3575.9 3620.8 3718.7 3734.9 3697.6 3726.1 3736.3 3743.6 3751.5 3514.5 3697.6 3699.1 3708.5 3733.7 3525.8 3731.8 3745.7 3746.2 3761.0 3323.9 3331.0 3332.9 3334.5 3340.1 4513.4 4518.6 4544.0 4570.7 4572.6 3926.4 4195.7 4202.3 4211.1 4234.7 4870.3 4910.5 4914.5 4926.1 4931.3 3477.8 3484.8 3496.6 3498.8 3503.6 4958.3 4991.1 5027.9 5127.6 5145.3 3487.3 3502.4 3526.2 3528.8 3535.5 3539.7 3547.9 3558.0 3569.6 3594.9 4061.9 4081.5 4083.0 4120.7 4133.3 4750.0 4914.9 4915.7 4921.8 4937.1 1306.9 1315.5 1317.7 1318.6 1323.5 824.4 862.2 876.3 894.4 897.9 4602.3 4619.1 4620.6 4641.5 4653.3 5333.3 5344.5 5346.1 5346.4 5359.2 4496.2 4593.4 4609.4 4628.1 4657.6 2823.8 2854.0 2857.5 2859.6 2869.5 5010.3 5029.7 5043.7 5043.8 5045.9 5230.9 5433.8 5439.2 5458.2 5476.5 5009.2 5023.6 5031.7 5048.1 5054.5 5326.4 5329.5 5342.7 5358.4 5378.7 4730.2 5060.9 5063.3 5068.8 5077.9 4805.6 4842.4 4859.0 4875.4 4875.6 3582.0 3591.4 3612.7 3614.4 3627.5 4815.7 5111.9 5118.6 5133.7 5153.4 4939.4 4966.8 4975.2 4986.0 5001.4 4917.8 4973.8 4976.8 4987.6 4998.2 4622.7 4792.4 4885.9 4891.3 4919.4 4811.2 4961.2 4976.5 4996.8 5001.2 4832.2 4857.0 4872.9 4880.9 4884.9 16:11:57 INFO - PROCESS | 16493 | 16:11:57 INFO - PROCESS | 16493 | [#5] yui.html Cycles:180 Average:12865.80 Median:24054.07 stddev:14520.96 (60.4%) stddev-sans-first:14532.61 16:11:57 INFO - PROCESS | 16493 | Values: 627.8 692.4 752.9 756.9 781.9 11851.2 12217.3 12315.6 12346.6 12429.9 11373.5 11379.8 11389.9 11390.3 11510.3 636.7 774.5 786.4 804.0 807.5 794.1 800.3 801.6 802.4 803.1 840.4 846.6 847.3 847.6 847.8 662.3 815.4 835.8 849.6 850.1 601.2 605.1 611.0 611.4 611.6 11389.3 11454.3 11468.2 11472.6 11493.9 10548.0 11401.5 11510.5 11844.0 11942.4 11155.2 11226.6 11304.4 11371.1 11411.4 4129.9 4174.5 4226.3 4226.8 4395.6 42964.4 43197.4 43215.4 43310.8 43485.0 9756.7 9773.9 9908.7 9913.0 10178.7 17734.2 17945.0 17975.0 17983.9 18042.6 6434.5 6899.5 6942.5 7003.9 7047.0 3622.9 3689.6 3700.4 3705.0 3731.1 2767.8 2845.5 2846.7 2847.1 2849.9 526.7 536.2 538.2 539.9 542.9 586.6 637.9 648.1 661.5 672.9 8043.1 8089.0 8121.8 8197.7 8245.8 466.8 503.5 505.9 572.2 578.6 3863.4 3885.7 3940.7 4018.1 4054.4 49992.0 52058.2 52253.0 52396.5 52450.7 46799.8 47249.0 47464.5 48793.0 49146.5 43712.6 44491.0 44498.0 44921.3 45409.8 7649.6 8023.9 8369.2 8446.9 8634.1 29813.3 29944.3 30002.4 30020.2 30068.8 36894.3 39932.4 40646.6 41274.8 41903.2 9898.9 9937.0 10220.1 10258.4 10935.5 11776.6 12214.5 12292.3 12330.8 12335.2 10662.3 10777.5 10918.0 11007.2 11272.6 11140.0 11704.2 11747.5 11755.3 11827.8 11153.4 11181.8 11538.0 11719.2 11775.9 9498.3 9548.7 9739.5 10320.9 10406.2 9096.8 9249.4 9275.4 9335.7 9381.2 16:11:57 INFO - PROCESS | 16493 | -------- Summary: end -------- 16:11:57 INFO - PROCESS | 16493 | 16:11:57 INFO - TEST-INFO | 16493: exit 0 16:11:57 INFO - TEST-OK | dromaeo_css | took 1118470ms 16:11:57 INFO - TEST-START | kraken 16:11:57 INFO - operating with platform_type : linux_ 16:11:57 INFO - Initialising browser for kraken test... 16:11:57 INFO - TEST-INFO | started process 16667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGofn8C/profile http://localhost:55465/getInfo.html) 16:12:02 INFO - PROCESS | 16667 | __metrics Screen width/height:1600/1200 16:12:02 INFO - PROCESS | 16667 | colorDepth:24 16:12:02 INFO - PROCESS | 16667 | Browser inner width/height: 1024/697 16:12:02 INFO - PROCESS | 16667 | __metrics 16:12:03 ERROR - PROCESS | 16667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:12:04 INFO - TEST-INFO | 16667: exit 0 16:12:04 INFO - Browser initialized. 16:12:04 INFO - Running cycle 1/1 for kraken test... 16:12:04 INFO - TEST-INFO | started process 16752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGofn8C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:16 INFO - PROCESS | 16752 | RSS: Main: 156917760 16:12:16 INFO - PROCESS | 16752 | 16:12:18 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55465/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:19 INFO - PROCESS | 16752 | RSS: Main: 210616320 16:12:19 INFO - PROCESS | 16752 | 16:12:22 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55465/tests/kraken/driver.html?testName=audio-dft) 16:12:23 INFO - PROCESS | 16752 | RSS: Main: 196108288 16:12:23 INFO - PROCESS | 16752 | 16:12:26 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55465/tests/kraken/driver.html?testName=audio-fft) 16:12:26 INFO - PROCESS | 16752 | RSS: Main: 268148736 16:12:26 INFO - PROCESS | 16752 | 16:12:29 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55465/tests/kraken/driver.html?testName=audio-oscillator) 16:12:29 INFO - PROCESS | 16752 | RSS: Main: 174821376 16:12:29 INFO - PROCESS | 16752 | 16:12:31 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:32 INFO - PROCESS | 16752 | RSS: Main: 179531776 16:12:32 INFO - PROCESS | 16752 | 16:12:35 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55465/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:36 INFO - PROCESS | 16752 | RSS: Main: 215261184 16:12:36 INFO - PROCESS | 16752 | 16:12:39 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55465/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:40 INFO - PROCESS | 16752 | RSS: Main: 216059904 16:12:40 INFO - PROCESS | 16752 | 16:12:43 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55465/tests/kraken/driver.html?testName=json-parse-financial) 16:12:43 INFO - PROCESS | 16752 | RSS: Main: 217272320 16:12:43 INFO - PROCESS | 16752 | 16:12:45 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:46 INFO - PROCESS | 16752 | RSS: Main: 202223616 16:12:46 INFO - PROCESS | 16752 | 16:12:48 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55465/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:48 INFO - PROCESS | 16752 | RSS: Main: 202690560 16:12:48 INFO - PROCESS | 16752 | 16:12:50 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:51 INFO - PROCESS | 16752 | RSS: Main: 216858624 16:12:51 INFO - PROCESS | 16752 | 16:12:54 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:54 INFO - PROCESS | 16752 | RSS: Main: 224518144 16:12:54 INFO - PROCESS | 16752 | 16:12:58 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:58 INFO - PROCESS | 16752 | RSS: Main: 220905472 16:12:58 INFO - PROCESS | 16752 | 16:13:00 INFO - PROCESS | 16752 | Cycle 1(1): loaded http://localhost:55465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55465/tests/kraken/driver.html?testName=ai-astar) 16:13:01 INFO - PROCESS | 16752 | RSS: Main: 284389376 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | __start_tp_report 16:13:01 INFO - PROCESS | 16752 | _x_x_mozilla_page_load 16:13:01 INFO - PROCESS | 16752 | _x_x_mozilla_page_load_details 16:13:01 INFO - PROCESS | 16752 | |i|pagename|runs| 16:13:01 INFO - PROCESS | 16752 | |0;ai-astar;113;117;110;116;115;115;104;114;114;115 16:13:01 INFO - PROCESS | 16752 | |1;audio-beat-detection;153;139;157;180;132;157;169;134;193;132 16:13:01 INFO - PROCESS | 16752 | |2;audio-dft;161;162;162;162;162;162;162;160;162;160 16:13:01 INFO - PROCESS | 16752 | |3;audio-fft;74;75;107;105;75;74;74;124;104;73 16:13:01 INFO - PROCESS | 16752 | |4;audio-oscillator;95;100;141;94;96;95;148;94;94;149 16:13:01 INFO - PROCESS | 16752 | |5;imaging-gaussian-blur;118;117;117;117;116;116;117;117;117;117 16:13:01 INFO - PROCESS | 16752 | |6;imaging-darkroom;146;146;146;146;146;146;146;145;145;146 16:13:01 INFO - PROCESS | 16752 | |7;imaging-desaturate;95;94;95;95;94;94;95;94;94;95 16:13:01 INFO - PROCESS | 16752 | |8;json-parse-financial;65;67;66;67;67;67;71;81;65;64 16:13:01 INFO - PROCESS | 16752 | |9;json-stringify-tinderbox;64;64;65;65;65;64;64;65;65;65 16:13:01 INFO - PROCESS | 16752 | |10;stanford-crypto-aes;87;79;79;80;80;80;79;81;80;80 16:13:01 INFO - PROCESS | 16752 | |11;stanford-crypto-ccm;138;137;134;134;133;135;143;137;185;145 16:13:01 INFO - PROCESS | 16752 | |12;stanford-crypto-pbkdf2;219;217;216;215;216;218;217;219;220;217 16:13:01 INFO - PROCESS | 16752 | |13;stanford-crypto-sha256-iterative;75;76;75;74;78;75;74;73;74;74 16:13:01 INFO - PROCESS | 16752 | __end_tp_report 16:13:01 INFO - PROCESS | 16752 | __start_cc_report 16:13:01 INFO - PROCESS | 16752 | _x_x_mozilla_cycle_collect,1904 16:13:01 INFO - PROCESS | 16752 | __end_cc_report 16:13:01 INFO - PROCESS | 16752 | __startTimestamp1461712381027__endTimestamp 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | ------- Summary: start ------- 16:13:01 INFO - PROCESS | 16752 | Number of tests: 14 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.77 (3.3%) stddev-sans-first:4.00 16:13:01 INFO - PROCESS | 16752 | Values: 113.0 117.0 110.0 116.0 115.0 115.0 104.0 114.0 114.0 115.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:157.00 stddev:21.16 (13.5%) stddev-sans-first:22.44 16:13:01 INFO - PROCESS | 16752 | Values: 153.0 139.0 157.0 180.0 132.0 157.0 169.0 134.0 193.0 132.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 16:13:01 INFO - PROCESS | 16752 | Values: 161.0 162.0 162.0 162.0 162.0 162.0 162.0 160.0 162.0 160.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#3] audio-fft Cycles:10 Average:88.50 Median:74.00 stddev:19.29 (26.1%) stddev-sans-first:19.74 16:13:01 INFO - PROCESS | 16752 | Values: 74.0 75.0 107.0 105.0 75.0 74.0 74.0 124.0 104.0 73.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:94.00 stddev:24.58 (26.1%) stddev-sans-first:25.41 16:13:01 INFO - PROCESS | 16752 | Values: 95.0 100.0 141.0 94.0 96.0 95.0 148.0 94.0 94.0 149.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 16:13:01 INFO - PROCESS | 16752 | Values: 118.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:13:01 INFO - PROCESS | 16752 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 16:13:01 INFO - PROCESS | 16752 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:67.00 stddev:4.94 (7.4%) stddev-sans-first:5.12 16:13:01 INFO - PROCESS | 16752 | Values: 65.0 67.0 66.0 67.0 67.0 67.0 71.0 81.0 65.0 64.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 16:13:01 INFO - PROCESS | 16752 | Values: 64.0 64.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:2.37 (3.0%) stddev-sans-first:0.67 16:13:01 INFO - PROCESS | 16752 | Values: 87.0 79.0 79.0 80.0 80.0 80.0 79.0 81.0 80.0 80.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:137.50 stddev:15.57 (11.3%) stddev-sans-first:16.45 16:13:01 INFO - PROCESS | 16752 | Values: 138.0 137.0 134.0 134.0 133.0 135.0 143.0 137.0 185.0 145.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:217.40 Median:217.50 stddev:1.58 (0.7%) stddev-sans-first:1.56 16:13:01 INFO - PROCESS | 16752 | Values: 219.0 217.0 216.0 215.0 216.0 218.0 217.0 219.0 220.0 217.0 16:13:01 INFO - PROCESS | 16752 | 16:13:01 INFO - PROCESS | 16752 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.00 stddev:1.40 (1.9%) stddev-sans-first:1.48 16:13:01 INFO - PROCESS | 16752 | Values: 75.0 76.0 75.0 74.0 78.0 75.0 74.0 73.0 74.0 74.0 16:13:01 INFO - PROCESS | 16752 | -------- Summary: end -------- 16:13:01 INFO - PROCESS | 16752 | 16:13:02 INFO - TEST-INFO | 16752: exit 0 16:13:02 INFO - TEST-OK | kraken | took 64199ms 16:13:02 INFO - SUITE-END | took 1182s 16:13:02 INFO - Completed test suite (00:19:42) 16:13:02 INFO - javascript benchmark 16:13:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2651.5359812032893, 2687.6102965070054, 2721.3740839606876, 2728.9999999999995, 2737.1104391072904, 4517.503074661785, 4638.420197475316, 4667.649926255532, 4677.95322046779, 4729.2433210686295, 4602.723836569809, 4649.651276154294, 4650.581447669709, 4653.232216684243, 4655.278431843061, 4215.473065866767, 4298.376735373369, 4313.309870420718, 4363.0619416825375, 4415.161119387322, 4303.483581970168, 4379.386885835986, 4395.824167033315, 4401.031773009932, 4428.822847086129, 4224.134052519226, 4298.183345164409, 4307.181635489247, 4312.094460163369, 4318.050028993616, 4261.637760790337, 4261.978690106561, 4264.87205383839, 4266.786660666954, 4270.402143699885, 4238.17355615652, 4240.851570195028, 4242.639375653073, 4243.724157929724, 4254.829806807724, 4521.819127234907, 4550.977245113786, 4577.244754615484, 4588.632909367243, 4602.0, 4938.925916111261, 4960.33035540201, 4966.230234313651, 4970.229614409773, 5011.599072074226, 4844.854654360375, 4981.900361992776, 4984.077945580079, 4996.075725990703, 5001.349824522788, 4671.205894997858, 4672.789724462339, 4688.2733176357715, 4711.764411779397, 4724.0, 5090.796368145233, 5095.821646242438, 5101.081805275012, 5121.897562048738, 5173.224016397495, 4802.063597598435, 4906.779194936236, 4911.9754401227765, 4953.157963146274, 4959.479254678279, 4971.850844474671, 4987.301777751118, 4998.125328067574, 5000.849974500771, 5032.446430892599, 4913.238448040559, 4955.331030310934, 4962.826301079445, 4969.900601988013, 4997.675151115166, 4833.975830120827, 4889.779959901813, 4977.850664480072, 4985.601151907838, 4988.575971042429, 4186.91626167475, 4199.601037901394, 4210.410542524049, 4217.683673724483, 4233.216854881856, 3715.3498137825773, 3716.8141592920247, 3735.4957080793747, 3736.3834967230646, 3757.0, 4256.638185754246, 4304.461942257218, 4329.350597410414, 4385.890352741143, 4389.144116897174, 5022.096022715873, 5034.270030845581, 5036.974815125901, 5042.445331013586, 5070.6957582545165, 4292.077203401283, 4340.088581397878, 4345.239583072949, 4365.454318210223, 4394.560543945579, 4390.692651514363, 4486.192485352668, 4523.547645235516, 4535.909281814345, 4564.041551274203, 4711.057788442326, 4724.858254252446, 4734.85795426124, 4736.763161841963, 4783.928241076456, 4884.169691152583, 5001.049800537886, 5019.171836646912, 5026.220935754964, 5073.670211436245, 4754.21555443348, 4773.522647735199, 4793.257045158006, 4810.927836082392, 4835.178019736582, 4896.461389247109, 4934.901301974012, 4935.506449355035, 4942.20924652054, 4990.700557966534, 4855.320255164351, 4976.328195693535, 4992.026554821775, 4995.275685025578, 5056.266841308064, 4852.878678033077, 4855.562999330077, 4873.488283730299, 4883.0, 4924.064427758714, 4847.587955023862, 4873.147199240189, 4877.146499362669, 4881.048195601824, 4916.311716359784, 4693.530646935279, 4754.0, 4811.591014763644, 4845.5881250094135, 4850.005748821412, 4866.80532778699, 4890.388701412324, 4905.117078925828, 4926.064047830901, 4953.950460495349, 4798.976005119952, 4802.039592081667, 4803.687760295569, 4804.2073057945045, 4847.321375007572], "value": 4592.3668562222865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.4110407384468, 606.3027518353894, 614.5943677173067, 624.0981781325983, 669.4343279928462, 27573.58639620405, 32272.677273227262, 33068.33863322735, 33085.5037174442, 33093.00720978375, 36478.0, 36997.26005479889, 37120.25759484809, 37191.814040929756, 37199.070023249435, 7417.369523590488, 7668.884966725504, 7669.309762121408, 7669.769906902802, 7673.769786906401, 7539.283768042054, 7691.730789422371, 7699.961500192519, 7701.037370328709, 7701.268379503967, 7540.8114797129965, 7585.7344992925255, 7588.0, 7588.430867684918, 7588.468807183499, 7619.542827430372, 7702.730404435818, 7703.0, 7705.075390953093, 7707.229277072276, 7524.661390237453, 7634.389248860133, 7638.083429988382, 7641.3122818946, 7644.350230230437, 33951.15122121942, 34517.13707157316, 34567.58026938116, 34576.82711586426, 34644.48033279503, 3091.9690803091908, 3168.6989735975044, 3217.4208642444582, 3497.4928635347733, 3727.4222495512968, 26436.0, 26543.734562654514, 26990.865045674844, 27037.864810676016, 27106.45787084267, 3293.1602441377295, 3313.96686033139, 3483.756137070406, 3493.2489514754448, 3534.240138370237, 177182.0, 177440.0, 177713.0, 177827.0, 177979.0, 45995.77002115035, 46681.5331846684, 46945.53054469411, 46950.295745563846, 46996.7650161747, 49464.0, 49623.25565116526, 49847.0, 49852.50147498551, 50001.0, 12845.614631561068, 12988.415521301375, 12997.15518491295, 13026.2835544046, 13031.0, 9660.227181825438, 9660.613575456902, 9660.806783864284, 9689.563969621244, 9695.321327507148, 13990.30048497571, 14721.779173312409, 14728.337224824694, 14821.40714371413, 14994.175320357484, 4966.1061009018, 5785.566082543742, 5840.766369345263, 5977.312609049928, 6030.884286407028, 897.6050537763364, 931.6878845586668, 971.9125278724948, 979.7452662307851, 1007.9949600251952, 24564.97344205859, 25461.61807572888, 26178.738212618013, 26585.867070664524, 27052.188434347, 951.1059603972244, 952.8142012307673, 954.9809003819885, 958.7171784323641, 1010.3533738407425, 13209.537666181637, 13826.239556824472, 13991.790123148161, 14060.648483787783, 14136.363863625957, 252788.0, 255388.0, 256182.0, 256291.0, 256686.0, 42104.1579168421, 42387.364189537184, 42476.15047699029, 42478.1504369917, 42511.787441063214, 1076.5962763963514, 1135.4663308245113, 1153.4982282707049, 1208.975820483603, 1249.5376710616947, 24312.0, 25761.871190643928, 26222.73777262203, 26259.343516411478, 26742.59886101671, 35453.645463545035, 35793.64206357903, 36089.27821443609, 36097.81951090228, 36138.45792313065, 171727.0, 172355.0, 172393.0, 173355.0, 173977.0, 19915.800841991975, 22016.229431970445, 22449.10203591838, 22461.0, 23297.301080967598, 33608.83195584006, 33631.327373452885, 33791.3241735159, 34675.826620866734, 34893.825530872185, 31043.68956310408, 31047.844760776956, 32079.754417190572, 32599.837000814845, 33003.66996330102, 28982.972528482565, 29654.40691186121, 29823.0, 30478.542821857245, 31039.53440698346, 32410.189745256557, 32851.835740821145, 33070.83464582662, 33114.83442582868, 33132.83433582816, 29168.27079323034, 29573.26066848346, 29620.407591848474, 29975.45208657201, 29997.0, 22977.310680679606, 22982.885085575133, 23361.766382335958, 23508.529829402974, 23606.881965590062], "value": 15629.518798932118, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.1135779807361, 382.26986455869286, 385.91316953685407, 386.5709062940134, 389.81678611052797, 15060.472883449082, 15712.764308535367, 16290.51128466145, 16438.0, 16475.17624118794, 12769.23384596925, 14440.350184241708, 14451.0, 14469.493567725132, 14470.987030907814, 3869.922601547967, 4779.713217206961, 4786.4974177711365, 4787.54518320759, 4799.280107983813, 4538.523455037207, 4734.26618874075, 4737.928931066037, 4738.407699037621, 4739.52604739525, 4726.243800991842, 5032.270320803481, 5329.706866122362, 5337.67973921564, 5343.225232341309, 5263.236830659552, 5274.235235890794, 5274.578033757329, 5278.076336641092, 5284.180951952453, 4924.3105965164905, 5263.973680131613, 5276.182191760283, 5277.577793776489, 5294.100002999499, 18310.26758929641, 18557.257709691596, 18950.81049189518, 19111.331103411452, 19146.521336966547, 1861.4322631597358, 1949.5710943592387, 2198.2855571939185, 2269.6482045283005, 2434.732179460258, 8669.609867555975, 8675.349348798802, 8893.510856902867, 8961.193492585633, 9296.30277729173, 1666.2585149608428, 1708.9914550427293, 1738.3741852932933, 1774.0065563284602, 1805.4673871208024, 55532.0, 56177.71911140459, 56970.430295696926, 57615.711921440125, 58339.708301458224, 9836.606535738634, 9916.405015699082, 9984.251181161442, 9994.200463962865, 10152.847707284396, 13585.184888906697, 13670.863291366959, 13676.589702308947, 13725.794113088312, 13727.931360343135, 6806.931930680729, 6811.352921472452, 6849.589024658537, 7020.7893763187185, 7034.085568876013, 6461.7738379157445, 6555.770548030796, 6627.867442651216, 6628.270890202074, 6661.233958094785, 4316.374125751749, 4410.871058105131, 4419.668524860648, 4462.799174037176, 4529.365888775574, 1842.54857559896, 1855.4062699935891, 1873.6721073812027, 1911.8168249864098, 1932.7970563090673, 771.6527562596854, 821.0639870547581, 948.4262021477045, 951.871497347863, 989.9505024748734, 15658.0, 15974.520764377086, 16065.0, 16112.436064737678, 16620.418285359956, 848.7114381110329, 869.1135042256863, 877.5480627476854, 912.8767616371838, 920.1810388754014, 9039.276857851357, 9089.31830112731, 9340.392874463138, 9446.811063778687, 9608.375455595364, 367352.0, 372546.0, 381488.0, 386335.0, 392644.0, 62033.0, 63356.36643633597, 63806.0, 64714.67642661757, 64956.35043649597, 904.5341649050744, 909.4225167018991, 931.8415869302235, 934.780326623243, 937.95310234488, 11243.325400475998, 14273.214973176575, 14495.912806539342, 14519.78220326717, 14700.77948830747, 28559.42881142324, 29448.852755736083, 30217.697823021488, 31926.52110218395, 32019.758616896594, 41723.1655366897, 42101.36847947344, 42380.36429453499, 42536.36195457132, 42697.57302426936, 7592.658330375036, 7652.0, 7732.188120247293, 7822.960885195537, 7862.0, 10195.949020254851, 11248.381339026431, 11331.660050198507, 11507.424628768695, 11527.250728702607, 10049.598016079275, 10093.798124037625, 10201.642942496977, 10231.079202871777, 10483.266171367932, 9803.460809655537, 9808.313418060667, 10249.231307651808, 10250.641227557298, 10297.0, 9921.503924803586, 10065.446400448045, 10135.442550659489, 10434.895521195376, 10499.842502362319, 7580.696772129053, 7761.185075566984, 7860.3318717909615, 7878.409119315959, 7915.722949696733, 8987.595558200028, 9926.15627671656, 10088.344257623232, 10278.691639250834, 10648.574057037631], "value": 7849.886823828217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.9817002744956, 1420.4531255466645, 1426.5720283914825, 1551.7362048451762, 1716.3821024431195, 6434.6139231646075, 7362.153352364473, 7576.886346704804, 7594.088709354885, 7599.810004749884, 7379.926200737991, 7543.924560754391, 7560.848783024337, 7565.0, 7567.886481702779, 1877.2491003598534, 2174.6737989301614, 2181.9454513637206, 2207.0619986505753, 2260.1298500077505, 2223.399682085836, 2251.6622506624058, 2252.909883604662, 2255.4248666589997, 2258.706368172135, 2134.391698365966, 2135.1459416233474, 2185.4317877351923, 2200.482886521666, 2203.5703037907615, 1821.4444594398703, 2106.494441334084, 2146.527763891941, 2164.729408823897, 2167.924122655715, 2134.1463414634113, 2136.925207617726, 2154.859934104278, 2159.3306075116766, 2159.730033745782, 7184.209736928934, 7230.0, 7266.927330726678, 7267.600281984489, 7295.562266264041, 4240.23675738367, 4429.82609608454, 4433.645308375322, 4439.200943830109, 4439.489458712257, 2886.5381538953875, 2895.363020135567, 2915.6355455568055, 2918.8394638294885, 2968.2876109733725, 834.9248567628882, 850.59596691571, 888.1118881118881, 896.7130518234168, 913.8492148795507, 10240.027197416308, 10266.794664106676, 10292.330998485075, 10315.896841031568, 10317.484125793755, 4217.97891010543, 4282.143571285756, 4319.654427645781, 4371.0, 4376.7811609419405, 8798.780030499289, 8808.779780505538, 8809.07504711996, 8858.911410885808, 8884.244839188612, 4499.505054444008, 4537.0925814837165, 4541.205289074464, 4541.409616749867, 4541.841035563805, 3670.4310831821113, 4051.493563304587, 4169.395437661522, 4175.54069052404, 4175.895602609899, 3470.583529976419, 3543.1319326765106, 3582.9283414331567, 3608.87368942091, 3649.9270014600093, 1193.2244041373176, 1193.3257709394165, 1196.186593116689, 1196.904247660185, 1198.9460474278503, 699.6431819771851, 874.9387542871938, 878.5299864572423, 891.7948871759531, 897.1297841094129, 5258.342707161605, 5430.321209848769, 5453.863653408696, 5512.118061110284, 5524.944750552523, 407.56390661991975, 410.38852110355356, 415.77963679250047, 417.17815902671686, 418.6483353982608, 3734.3651579231596, 3819.1597848473293, 3820.56063552695, 3846.8845934622004, 3879.2435475082652, 9189.494577798285, 9543.522823858779, 9574.569144388519, 9646.614135434644, 9668.951655241819, 9468.384555003902, 9542.379745316532, 9546.90453095474, 9552.37909535878, 9567.425954442755, 7217.0, 7320.633968301564, 7378.262173782686, 7404.296591823768, 7424.888626670604, 5309.0, 5349.117395629678, 5355.919661205007, 5584.525315348241, 5592.245046918777, 8219.630116644885, 8461.40770146084, 8492.490450572985, 8594.226519613265, 8598.828023439371, 8502.659893604186, 8581.485110893367, 8918.86621700688, 8924.776880578038, 9047.276217902683, 5963.0, 6573.868522629617, 6649.368310010541, 6749.898751518829, 6834.350736680008, 7343.559386436831, 7369.77890663281, 7428.368588669808, 7448.851022979402, 7449.4412919032375, 6605.0, 6704.363085506869, 6752.729890804313, 6863.759768408082, 6872.41584465326, 6670.499712521678, 6685.732570697312, 6695.4978376620975, 6746.662666866735, 6830.077939478107, 6370.90443643355, 6440.645764482999, 6517.869642607026, 6526.314736952551, 6527.445167160845, 4649.1863923812525, 4726.93483604107, 4823.758812059453, 4866.878328041686, 4872.342233798392, 4545.840895568639, 4548.47692515365, 4582.450105987303, 4591.678582499193, 4733.982193828343], "value": 4024.6318080268466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7042827600676, 300.0338908713941, 302.6625312776254, 302.83192827980474, 306.26038117945166, 4645.9070818583605, 4713.0573885223, 4717.268823332389, 4748.768079002872, 4776.0, 4654.44076234461, 4674.228752255874, 4685.3835426777705, 4695.71825690458, 4707.176244157267, 3494.1264683829045, 3575.8748443804343, 3620.81895905205, 3718.7210959178033, 3734.906627334311, 3697.611750766171, 3726.142987112966, 3736.2901048800777, 3743.644353786386, 3751.4747935289083, 3514.523899962009, 3697.6318762058077, 3699.1122130688577, 3708.5364329458816, 3733.701303895682, 3525.823708814549, 3731.7760934343755, 3745.662890339855, 3746.194568167857, 3761.0, 3323.88366407177, 3331.0, 3332.8833490827706, 3334.499825026241, 3340.1315657929113, 4513.435820522434, 4518.638508919278, 4544.0, 4570.702904311209, 4572.611328037121, 3926.4110383442426, 4195.7063005589625, 4202.327627579572, 4211.094614657833, 4234.724742891703, 4870.342503762017, 4910.508949105097, 4914.508549145093, 4926.064047830901, 4931.334269873557, 3477.80015894516, 3484.8083355415442, 3496.6328535503912, 3498.8425520851624, 3503.5795704515367, 4958.2562615607585, 4991.101601711727, 5027.874303142414, 5127.589792816566, 5145.25393817898, 3487.337405892872, 3502.387082260594, 3526.20660351424, 3528.835484290178, 3535.52270443492, 3539.681428671432, 3547.8935631931085, 3557.964420355815, 3569.607343192247, 3594.8741794037082, 4061.918761624751, 4081.510218773766, 4082.9581961438325, 4120.690948178899, 4133.297339452301, 4749.976250118727, 4914.926276105862, 4915.65590408668, 4921.769557610597, 4937.086638971802, 1306.9346532673328, 1315.4869600855675, 1317.6771690935782, 1318.6439661291397, 1323.5169163255343, 824.4435006370676, 862.2326129744532, 876.3252295732251, 894.3560636341823, 897.9102089790969, 4602.286645569942, 4619.145458090264, 4620.607248383858, 4641.466231383367, 4653.348531205634, 5333.333333333333, 5344.465553444625, 5346.117890548016, 5346.4118946915805, 5359.159645387951, 4496.19068567661, 4593.425821772278, 4609.400777898852, 4628.097520983376, 4657.6273898088075, 2823.84468854215, 2853.985730071378, 2857.5427931530853, 2859.556768700813, 2869.497837878405, 5010.323606313101, 5029.723365214875, 5043.697378157322, 5043.798248070109, 5045.899082018339, 5230.895382092413, 5433.755481003364, 5439.211314359396, 5458.235846981426, 5476.534494568006, 5009.24861270805, 5023.598112151019, 5031.748412579356, 5048.141815891381, 5054.545090941833, 5326.3874654413685, 5329.54698850602, 5342.732863356739, 5358.437364076716, 5378.731063446734, 4730.1958667027375, 5060.949390506048, 5063.3417655704525, 5068.847934561822, 5077.949220507748, 4805.6155507558615, 4842.4189097308545, 4858.951410485991, 4875.414950205998, 4875.6099512038245, 3581.997040828572, 3591.389463791214, 3612.692921101736, 3614.403623402109, 3627.4558816177782, 4815.686980346266, 5111.897762044812, 5118.616103792305, 5133.666311689728, 5153.3558305211845, 4939.43196532389, 4966.751662416937, 4975.228839529878, 4986.0, 5001.374828146481, 4917.754112294299, 4973.751312434291, 4976.751162441936, 4987.551120399182, 4998.1503144464805, 4622.722636641813, 4792.448868380181, 4885.851824821235, 4891.31521586971, 4919.434265059421, 4811.171754733319, 4961.231009193581, 4976.477469865757, 4996.750162491788, 5001.199808030698, 4832.178529650038, 4857.0, 4872.853814385574, 4880.92678609814, 4884.877878053077], "value": 3774.3944254964767, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.7740013595105, 692.3595674001548, 752.9308382097423, 756.9091708994921, 781.8944442500265, 11851.22967007144, 12217.328046957426, 12315.63053108407, 12346.62960111196, 12429.937850310747, 11373.488193031313, 11379.829302560469, 11389.886101138985, 11390.259633123842, 11510.251833630808, 636.6880228687955, 774.5468900693102, 786.4494853602473, 804.0, 807.4953154278576, 794.0986979777936, 800.3077338102529, 801.6472751989136, 802.3741481644298, 803.0724513187278, 840.357126798, 846.5894041389921, 847.2501835875233, 847.6397531049311, 847.771101802516, 662.327737346596, 815.4495715392087, 835.7826964989085, 849.5837039850429, 850.090403268503, 601.2004034633926, 605.1255935173676, 611.037615755183, 611.3825036712952, 611.5871786544064, 11389.259698119678, 11454.255473394203, 11468.19722619417, 11472.598459053977, 11493.885061149365, 10548.0, 11401.501144347725, 11510.539578416854, 11844.0, 11942.402879855972, 11155.219134660578, 11226.550937962471, 11304.434778261055, 11371.147163962736, 11411.372374519398, 4129.876103716893, 4174.457320548339, 4226.260404429213, 4226.767527785971, 4395.582419670126, 42964.355534667004, 43197.35203971943, 43215.35176972348, 43310.78344608288, 43485.0, 9756.707298781048, 9773.853392199122, 9908.653197138066, 9912.950435247922, 10178.745531361776, 17734.20196091153, 17945.0, 17975.0, 17983.910080449514, 18042.63914721698, 6434.485241180694, 6899.48253880961, 6942.548734332252, 7003.859922801617, 7046.964765176142, 3622.909427264287, 3689.575698794673, 3700.3524383232825, 3705.0, 3731.067233191702, 2767.79241556884, 2845.4593627210766, 2846.6868644449096, 2847.0889315418867, 2849.9145025649264, 526.7050451747034, 536.2198001907216, 538.2383926743693, 539.8596364945064, 542.8859939412689, 586.5542187937199, 637.85648229149, 648.1250312078656, 661.4509956735898, 672.8957011663102, 8043.130552635031, 8089.0, 8121.837563248702, 8197.672093116327, 8245.79385515355, 466.8249406472573, 503.46129641284205, 505.919052951526, 572.221778381401, 578.6383510306059, 3863.439801228806, 3885.65389063934, 3940.6650434712797, 4018.1160144768687, 4054.3715724062818, 49992.0, 52058.21912671313, 52253.0, 52396.47603523916, 52450.737746311024, 46799.76600116977, 47249.0, 47464.52535474601, 48793.0, 49146.508534914195, 43712.56287437085, 44491.0, 44498.0, 44921.326180107324, 45409.77295113503, 7649.61751912391, 8023.919760802551, 8369.238151410142, 8446.915530844613, 8634.136586341567, 29813.254668633457, 29944.25139371533, 30002.399952001273, 30020.2036208066, 30068.849655751583, 36894.262114758094, 39932.40101398539, 40646.59353406428, 41274.79362603168, 41903.1619367617, 9898.851517227391, 9936.950315248378, 10220.131288840532, 10258.43578603184, 10935.507902144582, 11776.646700598996, 12214.450349734461, 12292.262464252173, 12330.75338493243, 12335.198212116184, 10662.306950048533, 10777.461126943464, 10918.0, 11007.174461915549, 11272.605458808903, 11140.0, 11704.180707350744, 11747.530098795953, 11755.294682319089, 11827.822582661094, 11153.442327883411, 11181.832272515756, 11538.0, 11719.238249513754, 11775.941120294343, 9498.287628428034, 9548.665796697082, 9739.513024348613, 10320.948395257976, 10406.219533535166, 9096.818063638822, 9249.445033298023, 9275.443473391619, 9335.673251436167, 9381.249500040118], "value": 5985.20821278343, "unit": "score"}], "name": "dromaeo_css", "value": 6094.302170033516, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 110.0, 116.0, 115.0, 115.0, 104.0, 114.0, 114.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 139.0, 157.0, 180.0, 132.0, 157.0, 169.0, 134.0, 193.0, 132.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 160.0, 162.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 107.0, 105.0, 75.0, 74.0, 74.0, 124.0, 104.0, 73.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 141.0, 94.0, 96.0, 95.0, 148.0, 94.0, 94.0, 149.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 67.0, 67.0, 67.0, 71.0, 81.0, 65.0, 64.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 79.0, 80.0, 80.0, 80.0, 79.0, 81.0, 80.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 134.0, 134.0, 133.0, 135.0, 143.0, 137.0, 185.0, 145.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 217.0, 216.0, 215.0, 216.0, 218.0, 217.0, 219.0, 220.0, 217.0], "value": 217.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 74.0, 78.0, 75.0, 74.0, 73.0, 74.0, 74.0], "value": 74.8, "unit": "score"}], "name": "kraken", "value": 1633.1, "alertThreshold": 2.0}]} 16:13:02 INFO - Return code: 0 16:13:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:13:02 ERROR - # TBPL SUCCESS # 16:13:02 INFO - Running post-action listener: _resource_record_post_action 16:13:02 INFO - Running post-run listener: _resource_record_post_run 16:13:03 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524660736; Read time: 16; Write time: 402500 16:13:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 228978688; Read time: 0; Write time: 221884 16:13:03 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295682048; Read time: 16; Write time: 180616 16:13:03 INFO - Running post-run listener: _upload_blobber_files 16:13:03 INFO - Blob upload gear active. 16:13:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:13:03 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:04 INFO - (blobuploader) - INFO - Done attempting. 16:13:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:13:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:13:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:05 INFO - (blobuploader) - INFO - Done attempting. 16:13:05 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:05 INFO - Return code: 0 16:13:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f21d15f2a86cd4f654b03cc3f4f2fc543d54cb3bac1b83e41378cd5a764959b7315d998f8d77f0274603a7fd3ae5e016e8910c4779ca4c667a48fd9cc24a2f70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edbaad66352dcc9d8a4ae1fc9a8598f2160dcb4744d3f3ec0fb16593e9887338c48b3d064f9d58f43575a583df1f65f261a41d5ff85bf08b924a77d69e525763"} 16:13:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:05 INFO - Contents: 16:13:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f21d15f2a86cd4f654b03cc3f4f2fc543d54cb3bac1b83e41378cd5a764959b7315d998f8d77f0274603a7fd3ae5e016e8910c4779ca4c667a48fd9cc24a2f70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edbaad66352dcc9d8a4ae1fc9a8598f2160dcb4744d3f3ec0fb16593e9887338c48b3d064f9d58f43575a583df1f65f261a41d5ff85bf08b924a77d69e525763"} 16:13:05 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:05 INFO - Copying logs to upload dir... 16:13:05 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.857350 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-26 16:13:05.070761) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:13:05.074075) ========= 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=574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370 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/f21d15f2a86cd4f654b03cc3f4f2fc543d54cb3bac1b83e41378cd5a764959b7315d998f8d77f0274603a7fd3ae5e016e8910c4779ca4c667a48fd9cc24a2f70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edbaad66352dcc9d8a4ae1fc9a8598f2160dcb4744d3f3ec0fb16593e9887338c48b3d064f9d58f43575a583df1f65f261a41d5ff85bf08b924a77d69e525763"} build_url:https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/VtEy-H3WSUmJS95rBS74jg/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/f21d15f2a86cd4f654b03cc3f4f2fc543d54cb3bac1b83e41378cd5a764959b7315d998f8d77f0274603a7fd3ae5e016e8910c4779ca4c667a48fd9cc24a2f70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edbaad66352dcc9d8a4ae1fc9a8598f2160dcb4744d3f3ec0fb16593e9887338c48b3d064f9d58f43575a583df1f65f261a41d5ff85bf08b924a77d69e525763"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:13:05.099212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:13:05.099543) ========= 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=574dc5aafe09851ec43d388c000001b6-1461709788.824016-1965510370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:13:05.182752) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:13:05.183068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:13:05.183376) ========= ========= Total master_lag: 0.17 =========