builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1462553432.99 results: success (0) buildid: 20160506093416 builduid: d7e76a5802534f1d87fe6a7ae2743057 revision: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:32.986895) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:32.987297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:32.987584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.016204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.016518) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 09:50:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.4M=0s 2016-05-06 09:50:33 (35.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172055 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.201281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.201610) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015495 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.251795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.252102) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 --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 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 09:50:33,411 truncating revision to first 12 chars 2016-05-06 09:50:33,411 Setting DEBUG logging. 2016-05-06 09:50:33,411 attempt 1/10 2016-05-06 09:50:33,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98730e9d1455?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 09:50:33,663 unpacking tar archive at: fx-team-98730e9d1455/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535453 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.800683) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.800986) ========= script_repo_revision: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.801431) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.801742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:50:33.811927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-06 09:50:33.812241) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:50:34 INFO - MultiFileLogger online at 20160506 09:50:34 in /builds/slave/test 09:50:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:50:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:34 INFO - {'append_to_log': False, 09:50:34 INFO - 'base_work_dir': '/builds/slave/test', 09:50:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:50:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:34 INFO - 'branch': 'Fx-Team-Non-PGO', 09:50:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:34 INFO - 'config_files': ('talos/linux_config.py',), 09:50:34 INFO - 'default_actions': ('clobber', 09:50:34 INFO - 'read-buildbot-config', 09:50:34 INFO - 'download-and-extract', 09:50:34 INFO - 'populate-webroot', 09:50:34 INFO - 'create-virtualenv', 09:50:34 INFO - 'install', 09:50:34 INFO - 'run-tests'), 09:50:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:34 INFO - 'download_minidump_stackwalk': True, 09:50:34 INFO - 'download_symbols': 'ondemand', 09:50:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:34 INFO - 'installer_path': 'installer.exe', 09:50:34 INFO - 'log_level': 'info', 09:50:34 INFO - 'log_name': 'talos', 09:50:34 INFO - 'log_to_console': True, 09:50:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:50:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:50:34 INFO - 'opt_config_files': (), 09:50:34 INFO - 'pip_index': False, 09:50:34 INFO - 'sps_profile': False, 09:50:34 INFO - 'sps_profile_interval': 0, 09:50:34 INFO - 'suite': 'dromaeojs', 09:50:34 INFO - 'system_bits': '32', 09:50:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:34 INFO - 'title': 'talos-linux64-ix-018', 09:50:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:34 INFO - 'use_talos_json': True, 09:50:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:34 INFO - 'work_dir': 'build'} 09:50:34 INFO - ##### 09:50:34 INFO - ##### Running clobber step. 09:50:34 INFO - ##### 09:50:34 INFO - Running pre-action listener: _resource_record_pre_action 09:50:34 INFO - Running main action method: clobber 09:50:34 INFO - rmtree: /builds/slave/test/build 09:50:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:35 INFO - Running post-action listener: _resource_record_post_action 09:50:35 INFO - ##### 09:50:35 INFO - ##### Finished clobber step (success) 09:50:35 INFO - ##### 09:50:35 INFO - ##### 09:50:35 INFO - ##### Running read-buildbot-config step. 09:50:35 INFO - ##### 09:50:35 INFO - Running pre-action listener: _resource_record_pre_action 09:50:35 INFO - Running main action method: read_buildbot_config 09:50:35 INFO - Using buildbot properties: 09:50:35 INFO - { 09:50:35 INFO - "project": "", 09:50:35 INFO - "product": "firefox", 09:50:35 INFO - "script_repo_revision": "production", 09:50:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:50:35 INFO - "repository": "", 09:50:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:50:35 INFO - "buildid": "20160506093416", 09:50:35 INFO - "pgo_build": "False", 09:50:35 INFO - "basedir": "/builds/slave/test", 09:50:35 INFO - "buildnumber": 1661, 09:50:35 INFO - "slavename": "talos-linux64-ix-018", 09:50:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:50:35 INFO - "platform": "ubuntu64_hw", 09:50:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:50:35 INFO - "branch": "fx-team", 09:50:35 INFO - "repo_path": "integration/fx-team", 09:50:35 INFO - "revision": "98730e9d1455e5819b67a7bdfcd0bc976e509ff1", 09:50:35 INFO - "stage_platform": "linux64", 09:50:35 INFO - "builduid": "d7e76a5802534f1d87fe6a7ae2743057", 09:50:35 INFO - "slavebuilddir": "test" 09:50:35 INFO - } 09:50:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:50:35 INFO - Running post-action listener: _resource_record_post_action 09:50:35 INFO - ##### 09:50:35 INFO - ##### Finished read-buildbot-config step (success) 09:50:35 INFO - ##### 09:50:35 INFO - ##### 09:50:35 INFO - ##### Running download-and-extract step. 09:50:35 INFO - ##### 09:50:35 INFO - Running pre-action listener: _resource_record_pre_action 09:50:35 INFO - Running main action method: download_and_extract 09:50:35 INFO - mkdir: /builds/slave/test/build/tests 09:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:35 INFO - https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:50:39 INFO - Downloaded 1361 bytes. 09:50:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:50:39 INFO - Using the following test package requirements: 09:50:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:50:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:50:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:39 INFO - u'jsshell-linux-x86_64.zip'], 09:50:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:50:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:50:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:50:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:50:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:50:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:39 INFO - https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:50:52 INFO - Downloaded 22321850 bytes. 09:50:52 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'] 09:50:52 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 09:50:53 INFO - Return code: 0 09:50:53 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 09:50:53 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')]} 09:50:53 INFO - https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:50:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:50:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:50:56 INFO - Downloaded 22321850 bytes. 09:50:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:50:57 INFO - Return code: 0 09:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:57 INFO - https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:50:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:50:59 INFO - Downloaded 10840152 bytes. 09:50:59 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'] 09:50:59 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 09:50:59 INFO - Return code: 0 09:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:59 INFO - https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:50:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:50:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:50:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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 09:51:01 INFO - Downloaded 54842214 bytes. 09:51:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:51:01 INFO - mkdir: /builds/slave/test/properties 09:51:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:51:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:51:01 INFO - Contents: 09:51:01 INFO - build_url:https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:51:01 INFO - Running post-action listener: _resource_record_post_action 09:51:01 INFO - Running post-action listener: set_extra_try_arguments 09:51:01 INFO - ##### 09:51:01 INFO - ##### Finished download-and-extract step (success) 09:51:01 INFO - ##### 09:51:01 INFO - ##### 09:51:01 INFO - ##### Running populate-webroot step. 09:51:01 INFO - ##### 09:51:01 INFO - Running pre-action listener: _resource_record_pre_action 09:51:01 INFO - Running main action method: populate_webroot 09:51:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:01 INFO - '--tppagecycles', 09:51:01 INFO - '7'], 09:51:01 INFO - 'tests': ['tsvgm']}}, 09:51:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:51:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:51:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:01 INFO - 'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:01 INFO - 'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['damp', 'tps']}, 09:51:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:01 INFO - 'tests': ['damp', 'tps']}, 09:51:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['dromaeo_dom']}, 09:51:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['a11yr', 09:51:01 INFO - 'ts_paint', 09:51:01 INFO - 'tpaint', 09:51:01 INFO - 'sessionrestore', 09:51:01 INFO - 'sessionrestore_no_auto_restore', 09:51:01 INFO - 'tabpaint']}, 09:51:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:51:01 INFO - 'ts_paint', 09:51:01 INFO - 'tpaint', 09:51:01 INFO - 'sessionrestore', 09:51:01 INFO - 'sessionrestore_no_auto_restore', 09:51:01 INFO - 'tabpaint']}, 09:51:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:51:01 INFO - 'ts_paint', 09:51:01 INFO - 'tpaint', 09:51:01 INFO - 'sessionrestore', 09:51:01 INFO - 'sessionrestore_no_auto_restore', 09:51:01 INFO - 'tabpaint']}, 09:51:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:51:01 INFO - 'ts_paint', 09:51:01 INFO - 'tpaint', 09:51:01 INFO - 'sessionrestore', 09:51:01 INFO - 'sessionrestore_no_auto_restore', 09:51:01 INFO - 'tabpaint']}, 09:51:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['a11yr', 09:51:01 INFO - 'ts_paint', 09:51:01 INFO - 'tpaint', 09:51:01 INFO - 'sessionrestore', 09:51:01 INFO - 'sessionrestore_no_auto_restore', 09:51:01 INFO - 'tabpaint']}, 09:51:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['a11yr', 09:51:01 INFO - 'ts_paint', 09:51:01 INFO - 'tpaint', 09:51:01 INFO - 'sessionrestore', 09:51:01 INFO - 'sessionrestore_no_auto_restore', 09:51:01 INFO - 'tabpaint']}, 09:51:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['tsvgx', 09:51:01 INFO - 'tsvgr_opacity', 09:51:01 INFO - 'tart', 09:51:01 INFO - 'tscrollx', 09:51:01 INFO - 'cart']}, 09:51:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:51:01 INFO - 'tsvgr_opacity', 09:51:01 INFO - 'tart', 09:51:01 INFO - 'tscrollx', 09:51:01 INFO - 'cart']}, 09:51:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:01 INFO - 'talos_options': ['--disable-e10s'], 09:51:01 INFO - 'tests': ['tp5o']}, 09:51:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:01 INFO - 'tests': ['tp5o']}, 09:51:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:01 INFO - 'talos_options': ['--disable-e10s', 09:51:01 INFO - '--xperf_path', 09:51:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:01 INFO - 'tests': ['tp5n']}, 09:51:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:01 INFO - 'talos_options': ['--xperf_path', 09:51:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:01 INFO - 'tests': ['tp5n']}}, 09:51:01 INFO - 'talos.zip': {'path': '', 09:51:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:01 INFO - Running post-action listener: _resource_record_post_action 09:51:01 INFO - ##### 09:51:01 INFO - ##### Finished populate-webroot step (success) 09:51:01 INFO - ##### 09:51:01 INFO - ##### 09:51:01 INFO - ##### Running create-virtualenv step. 09:51:01 INFO - ##### 09:51:01 INFO - Running pre-action listener: _resource_record_pre_action 09:51:01 INFO - Running main action method: create_virtualenv 09:51:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:51:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:51:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:51:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:02 INFO - Using real prefix '/usr' 09:51:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:51:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:04 INFO - Installing pip.................done. 09:51:04 INFO - Return code: 0 09:51:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04ca19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', '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 09:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:51:04 INFO - Using env: {'DISPLAY': ':0', 09:51:04 INFO - 'HOME': '/home/cltbld', 09:51:04 INFO - 'LANG': 'en_US.UTF-8', 09:51:04 INFO - 'LANGUAGE': 'en_US:en', 09:51:04 INFO - 'LOGNAME': 'cltbld', 09:51:04 INFO - 'MAIL': '/var/mail/cltbld', 09:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:04 INFO - 'MOZ_NO_REMOTE': '1', 09:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:04 INFO - 'NO_EM_RESTART': '1', 09:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:04 INFO - 'PWD': '/builds/slave/test', 09:51:04 INFO - 'SHELL': '/bin/bash', 09:51:04 INFO - 'SHLVL': '1', 09:51:04 INFO - 'TERM': 'linux', 09:51:04 INFO - 'TMOUT': '86400', 09:51:04 INFO - 'USER': 'cltbld', 09:51:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:04 INFO - '_': '/tools/buildbot/bin/python'} 09:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:51:04 INFO - Cleaning up... 09:51:04 INFO - Return code: 0 09:51:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04ca19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', '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 09:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:51:04 INFO - Using env: {'DISPLAY': ':0', 09:51:04 INFO - 'HOME': '/home/cltbld', 09:51:04 INFO - 'LANG': 'en_US.UTF-8', 09:51:04 INFO - 'LANGUAGE': 'en_US:en', 09:51:04 INFO - 'LOGNAME': 'cltbld', 09:51:04 INFO - 'MAIL': '/var/mail/cltbld', 09:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:04 INFO - 'MOZ_NO_REMOTE': '1', 09:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:04 INFO - 'NO_EM_RESTART': '1', 09:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:04 INFO - 'PWD': '/builds/slave/test', 09:51:04 INFO - 'SHELL': '/bin/bash', 09:51:04 INFO - 'SHLVL': '1', 09:51:04 INFO - 'TERM': 'linux', 09:51:04 INFO - 'TMOUT': '86400', 09:51:04 INFO - 'USER': 'cltbld', 09:51:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:04 INFO - '_': '/tools/buildbot/bin/python'} 09:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:04 INFO - Downloading/unpacking psutil>=0.7.1 09:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:06 INFO - Installing collected packages: psutil 09:51:06 INFO - Running setup.py install for psutil 09:51:07 INFO - building 'psutil._psutil_linux' extension 09:51:07 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 09:51:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:51:07 INFO - building 'psutil._psutil_posix' extension 09:51:07 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 09:51:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:51:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:07 INFO - Successfully installed psutil 09:51:07 INFO - Cleaning up... 09:51:07 INFO - Return code: 0 09:51:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04ca19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', '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 09:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:51:07 INFO - Using env: {'DISPLAY': ':0', 09:51:07 INFO - 'HOME': '/home/cltbld', 09:51:07 INFO - 'LANG': 'en_US.UTF-8', 09:51:07 INFO - 'LANGUAGE': 'en_US:en', 09:51:07 INFO - 'LOGNAME': 'cltbld', 09:51:07 INFO - 'MAIL': '/var/mail/cltbld', 09:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:07 INFO - 'MOZ_NO_REMOTE': '1', 09:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:07 INFO - 'NO_EM_RESTART': '1', 09:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:07 INFO - 'PWD': '/builds/slave/test', 09:51:07 INFO - 'SHELL': '/bin/bash', 09:51:07 INFO - 'SHLVL': '1', 09:51:07 INFO - 'TERM': 'linux', 09:51:07 INFO - 'TMOUT': '86400', 09:51:07 INFO - 'USER': 'cltbld', 09:51:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:07 INFO - '_': '/tools/buildbot/bin/python'} 09:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:51:09 INFO - Installing collected packages: mozsystemmonitor 09:51:09 INFO - Running setup.py install for mozsystemmonitor 09:51:09 INFO - Successfully installed mozsystemmonitor 09:51:09 INFO - Cleaning up... 09:51:09 INFO - Return code: 0 09:51:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04ca19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', '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 09:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:51:09 INFO - Using env: {'DISPLAY': ':0', 09:51:09 INFO - 'HOME': '/home/cltbld', 09:51:09 INFO - 'LANG': 'en_US.UTF-8', 09:51:09 INFO - 'LANGUAGE': 'en_US:en', 09:51:09 INFO - 'LOGNAME': 'cltbld', 09:51:09 INFO - 'MAIL': '/var/mail/cltbld', 09:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:09 INFO - 'MOZ_NO_REMOTE': '1', 09:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:09 INFO - 'NO_EM_RESTART': '1', 09:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:09 INFO - 'PWD': '/builds/slave/test', 09:51:09 INFO - 'SHELL': '/bin/bash', 09:51:09 INFO - 'SHLVL': '1', 09:51:09 INFO - 'TERM': 'linux', 09:51:09 INFO - 'TMOUT': '86400', 09:51:09 INFO - 'USER': 'cltbld', 09:51:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:09 INFO - '_': '/tools/buildbot/bin/python'} 09:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:10 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 09:51:10 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 09:51:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - Downloading docopt-0.6.1.tar.gz 09:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:12 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:12 INFO - Running setup.py install for blobuploader 09:51:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:12 INFO - Running setup.py install for requests 09:51:13 INFO - Running setup.py install for docopt 09:51:13 INFO - Successfully installed blobuploader requests docopt 09:51:13 INFO - Cleaning up... 09:51:13 INFO - Return code: 0 09:51:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04ca19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', '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 09:51:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:13 INFO - Using env: {'DISPLAY': ':0', 09:51:13 INFO - 'HOME': '/home/cltbld', 09:51:13 INFO - 'LANG': 'en_US.UTF-8', 09:51:13 INFO - 'LANGUAGE': 'en_US:en', 09:51:13 INFO - 'LOGNAME': 'cltbld', 09:51:13 INFO - 'MAIL': '/var/mail/cltbld', 09:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:13 INFO - 'MOZ_NO_REMOTE': '1', 09:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:13 INFO - 'NO_EM_RESTART': '1', 09:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:13 INFO - 'PWD': '/builds/slave/test', 09:51:13 INFO - 'SHELL': '/bin/bash', 09:51:13 INFO - 'SHLVL': '1', 09:51:13 INFO - 'TERM': 'linux', 09:51:13 INFO - 'TMOUT': '86400', 09:51:13 INFO - 'USER': 'cltbld', 09:51:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:13 INFO - '_': '/tools/buildbot/bin/python'} 09:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:13 INFO - Running setup.py (path:/tmp/pip-g970zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:13 INFO - Running setup.py (path:/tmp/pip-RrxACu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:13 INFO - Running setup.py (path:/tmp/pip-Y2hsga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:13 INFO - Running setup.py (path:/tmp/pip-ZGocix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:13 INFO - Running setup.py (path:/tmp/pip-D9eMlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:13 INFO - Running setup.py (path:/tmp/pip-Rp6i12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:13 INFO - Running setup.py (path:/tmp/pip-odgvBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:13 INFO - Running setup.py (path:/tmp/pip-YyZM_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:14 INFO - Running setup.py (path:/tmp/pip-bKqMcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:14 INFO - Running setup.py (path:/tmp/pip-27EN9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:14 INFO - Running setup.py (path:/tmp/pip-aL8QuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:14 INFO - Running setup.py (path:/tmp/pip-OSjTUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:14 INFO - Running setup.py (path:/tmp/pip-gTycNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:14 INFO - Running setup.py (path:/tmp/pip-CREUTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:14 INFO - Running setup.py (path:/tmp/pip-AosWd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:14 INFO - Running setup.py (path:/tmp/pip-VcusYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:14 INFO - Running setup.py (path:/tmp/pip-CnWLxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:14 INFO - Running setup.py install for manifestparser 09:51:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:14 INFO - Running setup.py install for mozcrash 09:51:14 INFO - Running setup.py install for mozdebug 09:51:14 INFO - Running setup.py install for mozdevice 09:51:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Running setup.py install for mozfile 09:51:15 INFO - Running setup.py install for mozhttpd 09:51:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Running setup.py install for mozinfo 09:51:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Running setup.py install for mozInstall 09:51:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Running setup.py install for mozleak 09:51:15 INFO - Running setup.py install for mozlog 09:51:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Running setup.py install for moznetwork 09:51:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:15 INFO - Running setup.py install for mozprocess 09:51:15 INFO - Running setup.py install for mozprofile 09:51:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Running setup.py install for mozrunner 09:51:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Running setup.py install for mozscreenshot 09:51:16 INFO - Running setup.py install for moztest 09:51:16 INFO - Running setup.py install for mozversion 09:51:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:16 INFO - Cleaning up... 09:51:16 INFO - Return code: 0 09:51:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04ca19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', '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 09:51:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:16 INFO - Using env: {'DISPLAY': ':0', 09:51:16 INFO - 'HOME': '/home/cltbld', 09:51:16 INFO - 'LANG': 'en_US.UTF-8', 09:51:16 INFO - 'LANGUAGE': 'en_US:en', 09:51:16 INFO - 'LOGNAME': 'cltbld', 09:51:16 INFO - 'MAIL': '/var/mail/cltbld', 09:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:16 INFO - 'MOZ_NO_REMOTE': '1', 09:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:16 INFO - 'NO_EM_RESTART': '1', 09:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:16 INFO - 'PWD': '/builds/slave/test', 09:51:16 INFO - 'SHELL': '/bin/bash', 09:51:16 INFO - 'SHLVL': '1', 09:51:16 INFO - 'TERM': 'linux', 09:51:16 INFO - 'TMOUT': '86400', 09:51:16 INFO - 'USER': 'cltbld', 09:51:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:16 INFO - '_': '/tools/buildbot/bin/python'} 09:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:16 INFO - Running setup.py (path:/tmp/pip-ygKXP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:16 INFO - Running setup.py (path:/tmp/pip-fZ4c21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:16 INFO - Running setup.py (path:/tmp/pip-5b2AO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:16 INFO - Running setup.py (path:/tmp/pip-_756zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:17 INFO - Running setup.py (path:/tmp/pip-vdy59a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:17 INFO - Running setup.py (path:/tmp/pip-OsM7kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:17 INFO - Running setup.py (path:/tmp/pip-h5yoHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:17 INFO - Running setup.py (path:/tmp/pip-KWNdNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:17 INFO - Running setup.py (path:/tmp/pip-Q0M18T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:17 INFO - Running setup.py (path:/tmp/pip-ACZMhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:17 INFO - Running setup.py (path:/tmp/pip-425K1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:17 INFO - Running setup.py (path:/tmp/pip-vSfiU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:17 INFO - Running setup.py (path:/tmp/pip-eF1a6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:17 INFO - Running setup.py (path:/tmp/pip-0p52G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:17 INFO - Running setup.py (path:/tmp/pip-6bK9xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:17 INFO - Running setup.py (path:/tmp/pip-h6gsBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:17 INFO - Running setup.py (path:/tmp/pip-g5ltSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:19 INFO - Downloading blessings-1.6.tar.gz 09:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:19 INFO - Installing collected packages: blessings 09:51:19 INFO - Running setup.py install for blessings 09:51:19 INFO - Successfully installed blessings 09:51:19 INFO - Cleaning up... 09:51:20 INFO - Return code: 0 09:51:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:20 INFO - Reading from file tmpfile_stdout 09:51:20 INFO - Current package versions: 09:51:20 INFO - argparse == 1.2.1 09:51:20 INFO - blessings == 1.6 09:51:20 INFO - blobuploader == 1.2.4 09:51:20 INFO - docopt == 0.6.1 09:51:20 INFO - manifestparser == 1.1 09:51:20 INFO - mozInstall == 1.12 09:51:20 INFO - mozcrash == 0.17 09:51:20 INFO - mozdebug == 0.1 09:51:20 INFO - mozdevice == 0.48 09:51:20 INFO - mozfile == 1.2 09:51:20 INFO - mozhttpd == 0.7 09:51:20 INFO - mozinfo == 0.9 09:51:20 INFO - mozleak == 0.1 09:51:20 INFO - mozlog == 3.1 09:51:20 INFO - moznetwork == 0.27 09:51:20 INFO - mozprocess == 0.22 09:51:20 INFO - mozprofile == 0.28 09:51:20 INFO - mozrunner == 6.11 09:51:20 INFO - mozscreenshot == 0.1 09:51:20 INFO - mozsystemmonitor == 0.0 09:51:20 INFO - moztest == 0.7 09:51:20 INFO - mozversion == 1.4 09:51:20 INFO - psutil == 3.1.1 09:51:20 INFO - requests == 1.2.3 09:51:20 INFO - wsgiref == 0.1.2 09:51:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04ca19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', '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 09:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:20 INFO - Using env: {'DISPLAY': ':0', 09:51:20 INFO - 'HOME': '/home/cltbld', 09:51:20 INFO - 'LANG': 'en_US.UTF-8', 09:51:20 INFO - 'LANGUAGE': 'en_US:en', 09:51:20 INFO - 'LOGNAME': 'cltbld', 09:51:20 INFO - 'MAIL': '/var/mail/cltbld', 09:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:20 INFO - 'MOZ_NO_REMOTE': '1', 09:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:20 INFO - 'NO_EM_RESTART': '1', 09:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:20 INFO - 'PWD': '/builds/slave/test', 09:51:20 INFO - 'SHELL': '/bin/bash', 09:51:20 INFO - 'SHLVL': '1', 09:51:20 INFO - 'TERM': 'linux', 09:51:20 INFO - 'TMOUT': '86400', 09:51:20 INFO - 'USER': 'cltbld', 09:51:20 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:20 INFO - '_': '/tools/buildbot/bin/python'} 09:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:51:20 INFO - Cleaning up... 09:51:20 INFO - Return code: 0 09:51:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04ca19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', '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 09:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:51:20 INFO - Using env: {'DISPLAY': ':0', 09:51:20 INFO - 'HOME': '/home/cltbld', 09:51:20 INFO - 'LANG': 'en_US.UTF-8', 09:51:20 INFO - 'LANGUAGE': 'en_US:en', 09:51:20 INFO - 'LOGNAME': 'cltbld', 09:51:20 INFO - 'MAIL': '/var/mail/cltbld', 09:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:20 INFO - 'MOZ_NO_REMOTE': '1', 09:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:20 INFO - 'NO_EM_RESTART': '1', 09:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:20 INFO - 'PWD': '/builds/slave/test', 09:51:20 INFO - 'SHELL': '/bin/bash', 09:51:20 INFO - 'SHLVL': '1', 09:51:20 INFO - 'TERM': 'linux', 09:51:20 INFO - 'TMOUT': '86400', 09:51:20 INFO - 'USER': 'cltbld', 09:51:20 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:20 INFO - '_': '/tools/buildbot/bin/python'} 09:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:20 INFO - Downloading/unpacking jsonschema 09:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:22 INFO - Downloading/unpacking functools32 (from jsonschema) 09:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:22 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:22 INFO - warning: no files found matching '*.txt' 09:51:22 INFO - no previously-included directories found matching 'build' 09:51:22 INFO - no previously-included directories found matching 'dist' 09:51:22 INFO - no previously-included directories found matching '.git*' 09:51:22 INFO - Installing collected packages: jsonschema, functools32 09:51:22 INFO - Running setup.py install for functools32 09:51:22 INFO - warning: no files found matching '*.txt' 09:51:22 INFO - no previously-included directories found matching 'build' 09:51:22 INFO - no previously-included directories found matching 'dist' 09:51:22 INFO - no previously-included directories found matching '.git*' 09:51:23 INFO - Successfully installed jsonschema functools32 09:51:23 INFO - Cleaning up... 09:51:23 INFO - Return code: 0 09:51:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04ca19df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', '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 09:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:51:23 INFO - Using env: {'DISPLAY': ':0', 09:51:23 INFO - 'HOME': '/home/cltbld', 09:51:23 INFO - 'LANG': 'en_US.UTF-8', 09:51:23 INFO - 'LANGUAGE': 'en_US:en', 09:51:23 INFO - 'LOGNAME': 'cltbld', 09:51:23 INFO - 'MAIL': '/var/mail/cltbld', 09:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:23 INFO - 'MOZ_NO_REMOTE': '1', 09:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:23 INFO - 'NO_EM_RESTART': '1', 09:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:23 INFO - 'PWD': '/builds/slave/test', 09:51:23 INFO - 'SHELL': '/bin/bash', 09:51:23 INFO - 'SHLVL': '1', 09:51:23 INFO - 'TERM': 'linux', 09:51:23 INFO - 'TMOUT': '86400', 09:51:23 INFO - 'USER': 'cltbld', 09:51:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:23 INFO - '_': '/tools/buildbot/bin/python'} 09:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:23 INFO - Downloading/unpacking flake8 09:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:51:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:51:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:51:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:25 INFO - no previously-included directories found matching 'docs/_build' 09:51:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:51:25 INFO - Running setup.py install for pep8 09:51:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:26 INFO - no previously-included directories found matching 'docs/_build' 09:51:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:51:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:51:26 INFO - Cleaning up... 09:51:26 INFO - Return code: 0 09:51:26 INFO - Running post-action listener: _resource_record_post_action 09:51:26 INFO - Running post-action listener: _start_resource_monitoring 09:51:26 INFO - Starting resource monitoring. 09:51:26 INFO - ##### 09:51:26 INFO - ##### Finished create-virtualenv step (success) 09:51:26 INFO - ##### 09:51:26 INFO - ##### 09:51:26 INFO - ##### Running install step. 09:51:26 INFO - ##### 09:51:26 INFO - Running pre-action listener: _resource_record_pre_action 09:51:26 INFO - Running main action method: install 09:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:26 INFO - Reading from file tmpfile_stdout 09:51:26 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:26 INFO - Reading from file tmpfile_stdout 09:51:26 INFO - Output received: 09:51:26 INFO - Usage: mozinstall [options] installer 09:51:26 INFO - Options: 09:51:26 INFO - -h, --help show this help message and exit 09:51:26 INFO - -d DEST, --destination=DEST 09:51:26 INFO - Directory to install application into. [default: 09:51:26 INFO - "/builds/slave/test"] 09:51:26 INFO - --app=APP Application being installed. [default: firefox] 09:51:26 INFO - mkdir: /builds/slave/test/build/application 09:51:26 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'] 09:51:26 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 09:51:42 INFO - Reading from file tmpfile_stdout 09:51:42 INFO - Output received: 09:51:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:51:42 INFO - Running post-action listener: _resource_record_post_action 09:51:42 INFO - ##### 09:51:42 INFO - ##### Finished install step (success) 09:51:42 INFO - ##### 09:51:42 INFO - ##### 09:51:42 INFO - ##### Running run-tests step. 09:51:42 INFO - ##### 09:51:42 INFO - Running pre-action listener: _resource_record_pre_action 09:51:42 INFO - Running main action method: run_tests 09:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:51:42 INFO - Python 2.7.3 09:51:42 INFO - Return code: 0 09:51:42 INFO - grabbing minidump binary from tooltool 09:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:42 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 0x1590410>, '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 0x1591310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15917a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:51:42 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 09:51:42 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 09:51:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:42 INFO - Return code: 0 09:51:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:51:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:51:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:51:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:51:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:51:43 INFO - Return code: 0 09:51:43 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/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:51:43 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/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:51:43 INFO - Using env: {'DISPLAY': ':0', 09:51:43 INFO - 'HOME': '/home/cltbld', 09:51:43 INFO - 'LANG': 'en_US.UTF-8', 09:51:43 INFO - 'LANGUAGE': 'en_US:en', 09:51:43 INFO - 'LOGNAME': 'cltbld', 09:51:43 INFO - 'MAIL': '/var/mail/cltbld', 09:51:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:51:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:43 INFO - 'MOZ_NO_REMOTE': '1', 09:51:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:43 INFO - 'NO_EM_RESTART': '1', 09:51:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:43 INFO - 'PWD': '/builds/slave/test', 09:51:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:51:43 INFO - 'SHELL': '/bin/bash', 09:51:43 INFO - 'SHLVL': '1', 09:51:43 INFO - 'TERM': 'linux', 09:51:43 INFO - 'TMOUT': '86400', 09:51:43 INFO - 'USER': 'cltbld', 09:51:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330', 09:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:43 INFO - '_': '/tools/buildbot/bin/python'} 09:51:43 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/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:51:43 INFO - mozversion application_buildid: 20160506093416 09:51:43 INFO - mozversion application_changeset: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 09:51:43 INFO - mozversion application_display_name: Nightly 09:51:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:43 INFO - mozversion application_name: Firefox 09:51:43 INFO - mozversion application_remotingname: firefox 09:51:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:51:43 INFO - mozversion application_vendor: Mozilla 09:51:43 INFO - mozversion application_version: 49.0a1 09:51:43 INFO - mozversion platform_buildid: 20160506093416 09:51:43 INFO - mozversion platform_changeset: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 09:51:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:51:43 INFO - mozversion platform_version: 49.0a1 09:51:43 INFO - using testdate: 1462553503 09:51:43 INFO - actual date: 1462553503 09:51:43 INFO - starting webserver on 'localhost:37528' 09:51:43 INFO - SUITE-START | Running 2 tests 09:51:43 INFO - TEST-START | dromaeo_css 09:51:43 INFO - operating with platform_type : linux_ 09:51:43 INFO - Initialising browser for dromaeo_css test... 09:51:43 INFO - TEST-INFO | started process 19050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOGZANW/profile http://localhost:37528/getInfo.html) 09:51:47 INFO - PROCESS | 19050 | __metrics Screen width/height:1600/1200 09:51:47 INFO - PROCESS | 19050 | colorDepth:24 09:51:47 INFO - PROCESS | 19050 | Browser inner width/height: 1024/697 09:51:47 INFO - PROCESS | 19050 | __metrics 09:51:48 ERROR - PROCESS | 19050 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:51:49 INFO - TEST-INFO | 19050: exit 0 09:51:49 INFO - Browser initialized. 09:51:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:51:49 INFO - TEST-INFO | started process 19130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOGZANW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:01 INFO - PROCESS | 19130 | RSS: Main: 154849280 09:52:01 INFO - PROCESS | 19130 | 09:52:53 INFO - PROCESS | 19130 | 1462553573038 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] 09:55:04 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:37528/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37528/tests/dromaeo/cssquery-ext.html) 09:55:05 INFO - PROCESS | 19130 | RSS: Main: 271994880 09:55:05 INFO - PROCESS | 19130 | 09:58:08 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:37528/tests/dromaeo/cssquery-ext.html (next: http://localhost:37528/tests/dromaeo/cssquery-jquery.html) 09:58:09 INFO - PROCESS | 19130 | RSS: Main: 241074176 09:58:09 INFO - PROCESS | 19130 | 10:01:11 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:37528/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37528/tests/dromaeo/cssquery-mootools.html) 10:01:11 INFO - PROCESS | 19130 | RSS: Main: 240910336 10:01:11 INFO - PROCESS | 19130 | 10:04:14 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:37528/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37528/tests/dromaeo/cssquery-prototype.html) 10:04:14 INFO - PROCESS | 19130 | RSS: Main: 224796672 10:04:14 INFO - PROCESS | 19130 | 10:07:17 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:37528/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37528/tests/dromaeo/cssquery-yui.html) 10:07:18 INFO - PROCESS | 19130 | RSS: Main: 213999616 10:07:18 INFO - PROCESS | 19130 | 10:10:21 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:37528/tests/dromaeo/cssquery-yui.html (next: http://localhost:37528/tests/dromaeo/cssquery-dojo.html) 10:10:21 INFO - PROCESS | 19130 | RSS: Main: 312938496 10:10:21 INFO - PROCESS | 19130 | 10:10:21 INFO - PROCESS | 19130 | __start_tp_report 10:10:21 INFO - PROCESS | 19130 | _x_x_mozilla_page_load 10:10:21 INFO - PROCESS | 19130 | _x_x_mozilla_page_load_details 10:10:21 INFO - PROCESS | 19130 | |i|pagename|runs| 10:10:21 INFO - PROCESS | 19130 | |0;dojo.html;2613.8170328077035;2625.973740262597;2669.039145907473;2680.504106740252;2681.4100897802477;4622.5377462253755;4646.674732768707;4674.182018146827;4693.178693728601;4719.009008108297;4727.90544189116;4741.762911854411;4777.8805529861775;4809.182438985372;4829.22732362822;4290.635295999836;4317;4326.156399502099;4449.443819522559;4454.754988475633;4410.911781764363;4411.647068234533;4430.025394413224;4448.466184057917;4460.50934397216;4201.810918508674;4246.745195288293;4357.237483440417;4392.29723244281;4401.757903315316;4284.250256205151;4292.849750258726;4299.849505267332;4300.13997200558;4323.632491238249;4315.633171180422;4337.97831010846;4342.934855977162;4380.693351465398;4387.341898715218;4496.213162696547;4608.193566125915;4692.41344831896;4694.600958918496;4706.788194531255;5052.898942021139;5139.486051394868;5140.1004824155625;5140.563052140536;5145.588352931756;5101.438841727407;5119.872003199913;5132.178851383761;5146.459621739701;5165.405978312467;4578.931316030262;4592.7014744041535;4605.562471565196;4742.668013239075;4799.18413869643;5100.4899510049445;5164.25118357836;5175.430702622709;5176.767045482962;5179.741012949337;4920.704757714549;4961.7519124044375;4971.204607262821;4971.975140124277;4974.328465657162;4927.9507204927495;4976.576990955809;5026.924596130988;5086.92369614456;5090.974545127325;5010.023045506091;5059.114654935372;5078.619103567247;5090.0583392072585;5115.1559992600805;5038.420581633159;5039.77321020555;5046.142155833517;5067.4932506749765;5077.873053173626;4235.195312890541;4258.638015768633;4269.786510674454;4305.009847735038;4383.1452866691325;3771.2834561433788;3785.1104990327253;3788.905277368088;3828.0238539172333;3838.3666694995013;4362.476502819619;4369.453818272716;4373.343998400265;4410.2282100632265;4414.359917811899;4962.454130045692;5003.424606170264;5045.47022562633;5061.291419201315;5077;4342.2835232186335;4362.018545827227;4364.8254069837485;4366.14860102277;4395.582419670126;4599.977000115045;4604.861854144381;4606.953930460652;4613.746243956548;4657.74382408964;4580.312953057068;4686.789094490756;4741.620670346433;4742.928856067093;4750.5249475052215;5071.416787069535;5081.745912704276;5094;5101.566366858859;5152.355955505562;4579.175748365193;4736.928946065881;4744.857654270378;4745.169595320874;4797.4482934462985;4872.853814385574;4872.926906096341;4897.338859254098;4924.384451943507;4928.778204980713;4917.926231106608;4964.751762411937;4965.28003439492;4968.577670897869;4984.576311013604;4730.219513780187;4856.247281671346;4967.3542439482635;4975.0796102721115;5028.069807085701;4881.145799485005;4892.779824907817;4913.115639184981;4937.382827146606;4984;4827.675357476665;4845.515448455127;4899.069176856386;4900.779464924016;4902.509749025069;4758.595519380891;4862.051899879631;4920.384951881015;4938.234573641092;4949.9257511138085;4686.390769199982;4714.057188562233;4739.099571081483;4739.360186374795;4763.595094416874 10:10:21 INFO - PROCESS | 19130 | |1;ext.html;565.4543365652147;602.217117746929;607.7811987684436;611.7828170999298;615.2893408113628;27909.581356279647;30514.389712205742;30521.694783052164;30569.694303056935;30641.38717225657;30313.242168945733;43641.34537981933;44512;44556;48378;7961;8075.232852878967;8077.192280771935;8079.394045446586;8082.838343233132;7973.800654983614;8037.196280371945;8050.637721302555;8054.758357249292;8057.315128214109;8031;8083;8089.393295502831;8090.595470226494;8098.676052957874;8004.319632831187;8038;8059.476134051268;8059.717909873127;8062;7907.881381779278;7972.0832104308165;7972.681092756283;7980.241877021674;7983.560904150328;40628.796856015826;40806;40920;40923.590764092274;40952.38571421401;3230.8707651693903;3492.7904325740283;3545.3795585772646;3802.448644946495;4056.067104565937;27175.1847444577;27271.590926136123;27935.860320698266;32057;32089;3373;3407.369636617234;3416.9829150854334;3425.2635683328203;3576.0763880232303;263373;263388;264896;265252.9999999981;265565;30301.545476817864;30988.53517197244;60905.39094609086;61923.69038154781;61987.070193947126;36286.63713362833;36384.45423318652;36453.81773091118;36467.27065458676;36490;14784.704305914036;14932.776008359884;14942;14946.925265373604;14947.1779052151;12284.508619655293;12318.938405307916;12422.503099875903;12427.502899884084;12428.62714118578;8336.166383361737;8354.58227088643;8422.53676047811;8428.410011299151;8478.3641226907;3240.643529211785;3246.610406751205;3250.0737289872272;3313.801171929692;3328.783629064103;931.1619542411748;950.496236994394;1018.2363227579316;1018.7962407518526;1044.6657069737612;29190.27024324409;30010;32374.514382284284;33773.32453350919;33841.64633414636;998.5955687946393;1038.2628333883029;1041.4376236832027;1046.1473898772476;1075.956961721538;15395.538133856002;15528.145951972523;15812.086804054949;15922.522324330288;15944.521664350088;383543;388348;389277;389650;391210;51955.48044519582;52512.73743631257;52583.21125183125;52685.47314526882;52690.73654631779;1173.0674114079327;1215.7568486302598;1295.9999999999811;1324.1723922548408;1352.6212660455087;29301.41397172087;29787.851060745423;30173.09480715582;30839.537406938463;30862;50055.74972125116;51889.22166167586;51974.740126299126;57060.71469642625;57127.42872571221;324455;329327;329329;330297;330574;33668.326633466706;39423.408648869714;39919;40270.79864600658;40435.595644043184;44323.11353772971;44785;44840.32739508845;45120.54879451163;45333.320000200685;36790.44814327734;37878.62121378861;38170.618293816704;38652.6134738649;38719;37522.437163443115;37708.2458350837;38029.61970380371;38376.6162338373;38734.418983715834;29471.557926631547;32975.175620609676;38547.229055419295;38894.80552597219;42156.57843421649;32935.835320823244;34076.488852667724;34250.314993700486;34597.65402345944;34829.477557836144;25727.485450290515;26066.609000864624;26316.4736705261;26391.20826375212;26454.677266137 10:10:21 INFO - PROCESS | 19130 | |2;jquery.html;373.9532558430197;380.14846743295027;385.48152734572;393.95469521005055;404.2440636010659;16140.515784526453;17063.74404383932;17751.3136252056;17886.195121219545;17916.55208619785;17081.316747330093;17353;17480.912595437007;18008.63982720345;18030.18864151113;5137.640365174449;5329.546988505982;5362.705051222181;5381.515663590276;5386.245925570423;3734.5518537775506;3806.3338915689783;3899.161680238748;6083.300420451638;6243.937560624404;6161.075838624198;6179.474744646711;6195;6198.938010619881;6208.441240288374;6143.354947730513;6155.969220153893;6157;6157.722902469377;6164.784232551884;3126.1559378967777;4996.650234483587;5321.414644389114;5326;5433.130699088167;20189.293374731813;20337.084831182634;20556.897215513975;20690.275840345515;20707.792922070737;2051.8974051297378;2073.2121793718443;2080.625487412265;2085.8539902206853;2093.8324934005245;12933.248392426953;13158.078934474495;13231;13485.865141348559;13950.093243939213;1741.5646088477881;1790.1407324484321;1819.672458957387;1841.558026073746;1861.525311045688;55277.894442111334;58240.12639810406;61336;63671.36328636747;63695.999999999534;10218.386896786216;10399.740006499898;10448.52981615829;10518;10597;14433.566992990227;14475.78286325706;14487.20320382389;14503.782443263359;14509;7233;7715.614219289013;7772.222777722295;7840.607969601497;7888.368930485547;7391;7403.370713489306;7552.093748750075;7559.470837041465;7571.848563028709;4369.853705332156;4437.622802061861;4461.843835465808;4493.955060449353;4583.495815460296;1834.2662934826176;1840;1860.702287633972;1878.7651543557056;1898.0604600722731;886.7561420609384;888.7955770172767;904.3488688144525;935.6678379175431;960.5437417226901;16480.0935948524;16908.830911690973;16968.321267149175;17443.21505532254;17669.55826104332;852.9872051919226;885;890.1276748786225;920.5719340506563;933.673214374977;9503.904960950302;9570.425774453555;9710.126088652056;9777.217822574177;9793.167580755715;398959;404192;404774;408829;409123;78116.2188378109;81572;82750.58624706838;84721.57639211764;85631;938.7324612485409;943.3820847344863;965.1120968708805;966.7679756858304;969.3941286695815;15144.54566363011;15460.690786184437;15481.612959676098;15831;15838.9208053959;35862.46206306855;36381.81809090938;37623;37817.24365512729;38148.42777358397;51482.742586288325;52272;53079.469205307454;53697;53898.461015389345;7826.726064587712;7897.1707970662255;7995.080565734782;8025.759227223192;8285.917140828757;8633.784155396166;10982.341059536453;11525.366104863977;11942.462589183682;11967.76064478723;5508.614396992172;8100.622894107898;8518.531480768617;10655.520501577603;10772.946135269274;10004.849442314227;10661.520231589751;10686.786264274515;10764.192685548458;10980;10602.681919542427;10804.189685773441;10831.675049748204;10894.61868834587;11006.339619622848;7831.569263690551;7923.534146182975;8196.42625016243;8209.343252539902;8258.710945117133;9729;10804.405757683402;10839.729006774578;10979.670609881716;11039.172062095535 10:10:21 INFO - PROCESS | 19130 | |3;mootools.html;1302.4464602543917;1522.3986525322498;1551.1468692219278;1732.8786984911062;1878.3144152384375;7140.785776426709;7443.851122977537;7452.701891924324;7628.466007379472;7630.961845190766;7471.850562988737;7624.390048796097;7631.961840190806;7637.045369328834;7650.34972027377;1859.414284500378;1919.4529559075665;2159.4601349662585;2225.1433198218683;2255.740589832174;2239.6192647250004;2264.1735766445295;2265.2864347730497;2266.784655457729;2267.6938613287243;2185.5082606413507;2205.106931692667;2230.397792595998;2232.586971410286;2236.39617303328;1817.9181936812809;2119.088791819517;2155.224119317045;2185.9234926777485;2189.4635814225617;2173.2393662218255;2175.0321107107343;2195.5169862630196;2197.110170380998;2197.7362716473967;7701.768946931545;7717;7744.457887947846;7757.456978011542;7762.340201082915;4403.075354175627;4538.9546104539195;4546.8635940921495;4547.954520454786;4555.954440455586;2745.272502786763;2767.6125342452074;2803.271149501124;2814.7185281471893;2878.3955369372457;880.4893161966045;900.3787386703154;909.899911009795;912.543728135932;915.9313051521096;10363.37819730811;10375.221858360654;10395.220358473145;10395.220358473145;10404.063634272876;4085.6527195188146;4222.683298752606;4266.466691663542;4290.549492303326;4298.398224248608;8876.911230887737;8905.51019693923;8912.287017038621;8921.107889211027;8923.063078376807;4534.569215924482;4539.296409056601;4559.088182363541;4564.6348292136545;4565.977170114128;3672.2288319452678;4019.537753158424;4143.109231515178;4144.937825932613;4178.7283826551175;3561.3589553880033;3575.2313252650806;3617.94573081404;3625.4018087015347;3701.648898152155;1208.1422190245025;1223.7613665335175;1233.5065973610629;1236.07912105482;1242.5526810348267;707.1514182980444;819.4264015189273;871.1027641529236;899.3794281945437;928.2991341537231;5199.974000129975;5282.947170528246;5320.680759154463;5410.702411367334;5434.565234781208;907.491804589432;908.7228395339484;911.125319693102;913.8263729891299;925.5233554719325;3713.9814300928324;3719.6466335698065;3735.1409175889153;3763.096856754359;3770.547534295902;9020.233280171127;9459.148676619137;9488.098630630078;9515.096065873731;9532.142107210246;9341.159295663423;9353.485558294358;9369.156775890202;9425.151736343762;9464.337496375325;6981.965090174516;7072.045273887959;7087.82280442993;7120.074390329224;7142.142942846892;5024.171011783161;5091.287219789158;5162.870928226825;5208.24480450325;5230.163173892159;8288.336933045463;8416.242538171595;8496.53269070207;8509.829803403773;8581.785455363417;8357.164283571594;8515.233628973423;8589.742307730528;8628.180322869317;8681.956590217262;5404.54061404785;6113.694315284129;6247.12540244357;6249.50003999688;6338.746450141943;7463.067116610424;7494.662740176815;7516.8496630066;7529.134149572869;7543.283388078124;6660.433863121689;6854.417374523221;6875.48433867472;6966.930330696831;6984.231734509099;6113.205283313141;6146.262448506208;6754.560953538201;6780.627065511247;6818.113645226089;6242.375762423721;6286.119943208046;6311.715972781328;6312.116303717391;6312.7159277833525;4324.632406245504;4476.350929115325;4508.368828363966;4522.3442600823355;4591.265397536378;4689.202835517902;4703.647226457961;4733.431988161305;4735.763211839326;4740.597049250852 10:10:21 INFO - PROCESS | 19130 | |4;prototype.html;303.9149038269284;309.5867017531595;314.8897885739991;317.74739082429465;318.86926360192325;4676.462206846214;4752.667313288062;4786.736729479877;4799.712017278961;4842.95157048429;4508.954910450894;4593.333966574844;4600.355950166971;4619.58423741864;4689.038747056854;3610.855565777379;3623.5108260384773;3671.430928206132;3708.8701895433665;3720.8883733488037;3709.517762690846;3723.4042553191493;3726;3752.08074021865;3756.8685096021645;3632;3689.1514951561157;3720.683741881943;3723.813809309537;3729.936967964131;3699.9290588811223;3706.184639379332;3710.3321402147603;3731.776093434389;3739.439084137374;3310.817905015223;3311.4867195584725;3321.651226621194;3356.2448449099;3359.160209947513;4453.752949174236;4489.6408287336935;4503.860666183569;4505.932411013838;4536.455625324949;4130.586941305875;4206.642435392995;4256.127493863751;4277.871663850089;4282.850100246507;4784.904301913977;4832.830850920201;4843.75781210938;4847;4850.417949846006;3632.5822530408814;3643.508126402928;3643.9635603643887;3651.7443778935485;3652.3337963286685;4843.612510999147;5083.491650834924;5109.233614957749;5142.894277730306;5148.588112950993;3550.218951830593;3551.2187318789825;3565.35823551758;3579.46308053794;3585.515955346047;3608.585012723518;3627.8004709741217;3633.5821380541574;3635.8000309982676;3636.8363423646;4134.276501612206;4151.086760912594;4151.73013754105;4152.190322887069;4169.854055108057;4696.882577935579;4880.585150262267;4927.975360123177;4932.457429682732;4947.604191664658;1206.390772659801;1211.8303437518755;1211.8606360268682;1212.42409855318;1214.1622280626339;794.7734895554739;831.2311112221292;847.9745607631781;855.8416692911832;858.5707146426787;4184.560621134798;4194.6853985951175;4205.411242426063;4242.851500197478;4254.255505286563;4879.658423910292;4882.975585122052;4887.560119589183;4909.87725306863;4923.679960802537;4112.814923328458;4174.7893110997475;4189.581041895786;4234.55537168599;4236.195122926634;2594.8962041518507;2603.5053339865367;2610.577235406708;2618.5679362904907;2621.84268943864;4514.480834704051;4524.366588677588;4542.205114105019;4621.329907163443;4625.653076019312;4815.807367705253;4905.351110400416;4906.901861962812;4980.9252861207115;5005.774740136702;4498.302763071729;4553.043860789271;4558.544145585482;4576.290674945389;4604.283472751093;4832.323474713473;4858.684185527929;4864.586510146677;4870.1233777920315;4872.43966943806;4585.358049872953;4730.2431610942085;4768.189407800752;4782.7847746850775;4805.351277577623;4535.773211339354;4553.977230113828;4583.966109823334;4595.575371634804;4598.149342371538;3466.826658667006;3482.773619714812;3497;3524.295140971867;3534.469829525489;4807.870150514556;4849.078675051729;4882;4929.338157394966;4951.603871690329;4656.67403281767;4994.775235114356;4998.3252260945765;5005.174146265971;5008.799648014185;4986.902881366093;4990.226514890198;5009.373828271466;5023.673461225008;5052.368453943257;4759.785809638505;4927.630427717864;4950.603951683928;4958.355413796184;4960.751962401793;4907.411110666742;4916.655834091579;4954.900901982012;4957.231629097496;5023.723695196799;4839.056384005085;4852.199387101089;4861.343718598086;4865.391826021747;4882.218844984785 10:10:21 INFO - PROCESS | 19130 | |5;yui.html;682.3381320119483;747.960335134164;791.608153963788;795.9482633628813;813.9837203255935;11829;11900.345480998552;11909.523619055228;11929.7614047719;12472.126951113425;12759.106862519628;13032.283224422654;13123.6719082023;13125.737485250313;13142.868571314284;873.8863947686792;880.1506546182932;887.3611000079965;887.4586502233665;887.4719541872576;671.3521451799013;849.7026040885702;878.9340799440035;881.2245224202693;885.2696525366566;913.3241401362977;918.9448633082003;920.0247737398346;920.4017388697333;922.1193759959257;707.7239876448137;902.702108304258;904.5341649050777;904.751193421811;905.6965916418008;661.163628010567;674.6559254780049;675.8141511084442;680.4590350671228;681.4820736240443;13220.405081771343;13268.800967985488;13270.73458530824;13271.270080145589;13290.601281961557;11778.293302401884;12081.758364832742;12125.333106679129;12229.327386993711;12658.240505569695;11342.773144537146;11344.092472602171;11379.601713940056;11575.073994080538;12087.697807554794;4131.256135897091;4223.36649502574;4241.151769646052;4247.766372849492;4281.678874084425;44320.3351949721;44466.77766611178;44568;44879.55120448819;44883.77558112221;10052.64815731446;10303.896961030443;10427.843582346271;10662.786744265071;10735.785284294427;18278.360257390927;18357.541061473305;18359.63280734378;18388.17253223608;18930.52673683169;6801.820191378929;6863.622500762406;6921.861562768817;7008.789736307817;7013.473989450812;3834.0223243073397;3853.537575490903;3854.4989151410136;3870.748401353903;3966.8214930328204;2905.099419180061;3022.3804120155314;3024.894128705485;3026.546018097303;3031.10582378199;542.8371488553497;550.3918170421706;555.7249161665002;560.017169866881;564.0552075273899;560.7560711090689;581.0847914534625;599.4574909706722;629.26061877294;648.2156590525423;7428;7479.663415146223;7658.349040331635;7711.768646940601;7823.647935842901;612.3264409149899;614.6435067660746;617.8362733875437;619.071392910634;629.3391938464686;3648.689861361814;3653.4337177737493;3740.214554943438;3834.559025712079;3850.7497012694084;47314.763426182646;49202.50797492051;49246.261306080436;52361;52461.475385245656;47711.761441192575;48251.5174848254;48633.756831215615;49080.26379604309;49148.508514915105;43896.3415548767;43902;44267.55732442634;44774.552254477036;44950.77524612356;8362.414630975773;8678.218960293603;8684.39209255346;8688.91311086881;8833.293336532934;28603.570946436237;28731.994380196593;29081.85459072691;29381.41237175287;30246.84876575603;36982.44526332054;39060.218795624496;39542.60457395389;39571.40642890416;40007.799961001176;10860.076893464144;11073.390963496762;11286.322820630789;11398.544058237909;11769.823452648388;11604.767904642029;11764.411779411166;12043.277403355827;12254.264744115026;12263.509459621871;11383.715407114889;11990.100742444525;12091.274523528617;12744.0441966851;12753.426095825525;11956.684764676053;12259.264444133381;12270.877291226974;12419.93790031044;12622.242665440102;10318.226133039901;10607.151427885596;10746.355218686904;10899.891001090205;10900.40047797347;9603.711888643353;10076.09315161639;10325.793484130425;10337.121344685786;10733.19501037441;8666.090060543553;8887.600057997277;9138.862917056382;9445.527723613654;9692.079252471003 10:10:21 INFO - PROCESS | 19130 | __end_tp_report 10:10:21 INFO - PROCESS | 19130 | __start_cc_report 10:10:21 INFO - PROCESS | 19130 | _x_x_mozilla_cycle_collect,1080 10:10:21 INFO - PROCESS | 19130 | __end_cc_report 10:10:21 INFO - PROCESS | 19130 | __startTimestamp1462554621353__endTimestamp 10:10:21 INFO - PROCESS | 19130 | 10:10:21 INFO - PROCESS | 19130 | ------- Summary: start ------- 10:10:21 INFO - PROCESS | 19130 | Number of tests: 6 10:10:21 INFO - PROCESS | 19130 | 10:10:21 INFO - PROCESS | 19130 | [#0] dojo.html Cycles:165 Average:4663.52 Median:4744.86 stddev:480.59 (10.1%) stddev-sans-first:454.37 10:10:21 INFO - PROCESS | 19130 | Values: 2613.8 2626.0 2669.0 2680.5 2681.4 4622.5 4646.7 4674.2 4693.2 4719.0 4727.9 4741.8 4777.9 4809.2 4829.2 4290.6 4317.0 4326.2 4449.4 4454.8 4410.9 4411.6 4430.0 4448.5 4460.5 4201.8 4246.7 4357.2 4392.3 4401.8 4284.3 4292.8 4299.8 4300.1 4323.6 4315.6 4338.0 4342.9 4380.7 4387.3 4496.2 4608.2 4692.4 4694.6 4706.8 5052.9 5139.5 5140.1 5140.6 5145.6 5101.4 5119.9 5132.2 5146.5 5165.4 4578.9 4592.7 4605.6 4742.7 4799.2 5100.5 5164.3 5175.4 5176.8 5179.7 4920.7 4961.8 4971.2 4972.0 4974.3 4928.0 4976.6 5026.9 5086.9 5091.0 5010.0 5059.1 5078.6 5090.1 5115.2 5038.4 5039.8 5046.1 5067.5 5077.9 4235.2 4258.6 4269.8 4305.0 4383.1 3771.3 3785.1 3788.9 3828.0 3838.4 4362.5 4369.5 4373.3 4410.2 4414.4 4962.5 5003.4 5045.5 5061.3 5077.0 4342.3 4362.0 4364.8 4366.1 4395.6 4600.0 4604.9 4607.0 4613.7 4657.7 4580.3 4686.8 4741.6 4742.9 4750.5 5071.4 5081.7 5094.0 5101.6 5152.4 4579.2 4736.9 4744.9 4745.2 4797.4 4872.9 4872.9 4897.3 4924.4 4928.8 4917.9 4964.8 4965.3 4968.6 4984.6 4730.2 4856.2 4967.4 4975.1 5028.1 4881.1 4892.8 4913.1 4937.4 4984.0 4827.7 4845.5 4899.1 4900.8 4902.5 4758.6 4862.1 4920.4 4938.2 4949.9 4686.4 4714.1 4739.1 4739.4 4763.6 10:10:21 INFO - PROCESS | 19130 | 10:10:21 INFO - PROCESS | 19130 | [#1] ext.html Cycles:180 Average:48340.26 Median:36640.22 stddev:87212.32 (238.0%) stddev-sans-first:87383.21 10:10:21 INFO - PROCESS | 19130 | Values: 565.5 602.2 607.8 611.8 615.3 27909.6 30514.4 30521.7 30569.7 30641.4 30313.2 43641.3 44512.0 44556.0 48378.0 7961.0 8075.2 8077.2 8079.4 8082.8 7973.8 8037.2 8050.6 8054.8 8057.3 8031.0 8083.0 8089.4 8090.6 8098.7 8004.3 8038.0 8059.5 8059.7 8062.0 7907.9 7972.1 7972.7 7980.2 7983.6 40628.8 40806.0 40920.0 40923.6 40952.4 3230.9 3492.8 3545.4 3802.4 4056.1 27175.2 27271.6 27935.9 32057.0 32089.0 3373.0 3407.4 3417.0 3425.3 3576.1 263373.0 263388.0 264896.0 265253.0 265565.0 30301.5 30988.5 60905.4 61923.7 61987.1 36286.6 36384.5 36453.8 36467.3 36490.0 14784.7 14932.8 14942.0 14946.9 14947.2 12284.5 12318.9 12422.5 12427.5 12428.6 8336.2 8354.6 8422.5 8428.4 8478.4 3240.6 3246.6 3250.1 3313.8 3328.8 931.2 950.5 1018.2 1018.8 1044.7 29190.3 30010.0 32374.5 33773.3 33841.6 998.6 1038.3 1041.4 1046.1 1076.0 15395.5 15528.1 15812.1 15922.5 15944.5 383543.0 388348.0 389277.0 389650.0 391210.0 51955.5 52512.7 52583.2 52685.5 52690.7 1173.1 1215.8 1296.0 1324.2 1352.6 29301.4 29787.9 30173.1 30839.5 30862.0 50055.7 51889.2 51974.7 57060.7 57127.4 324455.0 329327.0 329329.0 330297.0 330574.0 33668.3 39423.4 39919.0 40270.8 40435.6 44323.1 44785.0 44840.3 45120.5 45333.3 36790.4 37878.6 38170.6 38652.6 38719.0 37522.4 37708.2 38029.6 38376.6 38734.4 29471.6 32975.2 38547.2 38894.8 42156.6 32935.8 34076.5 34250.3 34597.7 34829.5 25727.5 26066.6 26316.5 26391.2 26454.7 10:10:21 INFO - PROCESS | 19130 | 10:10:21 INFO - PROCESS | 19130 | [#2] jquery.html Cycles:180 Average:24944.78 Median:404483.00 stddev:66765.08 (16.5%) stddev-sans-first:66926.88 10:10:21 INFO - PROCESS | 19130 | Values: 374.0 380.1 385.5 394.0 404.2 16140.5 17063.7 17751.3 17886.2 17916.6 17081.3 17353.0 17480.9 18008.6 18030.2 5137.6 5329.5 5362.7 5381.5 5386.2 3734.6 3806.3 3899.2 6083.3 6243.9 6161.1 6179.5 6195.0 6198.9 6208.4 6143.4 6156.0 6157.0 6157.7 6164.8 3126.2 4996.7 5321.4 5326.0 5433.1 20189.3 20337.1 20556.9 20690.3 20707.8 2051.9 2073.2 2080.6 2085.9 2093.8 12933.2 13158.1 13231.0 13485.9 13950.1 1741.6 1790.1 1819.7 1841.6 1861.5 55277.9 58240.1 61336.0 63671.4 63696.0 10218.4 10399.7 10448.5 10518.0 10597.0 14433.6 14475.8 14487.2 14503.8 14509.0 7233.0 7715.6 7772.2 7840.6 7888.4 7391.0 7403.4 7552.1 7559.5 7571.8 4369.9 4437.6 4461.8 4494.0 4583.5 1834.3 1840.0 1860.7 1878.8 1898.1 886.8 888.8 904.3 935.7 960.5 16480.1 16908.8 16968.3 17443.2 17669.6 853.0 885.0 890.1 920.6 933.7 9503.9 9570.4 9710.1 9777.2 9793.2 398959.0 404192.0 404774.0 408829.0 409123.0 78116.2 81572.0 82750.6 84721.6 85631.0 938.7 943.4 965.1 966.8 969.4 15144.5 15460.7 15481.6 15831.0 15838.9 35862.5 36381.8 37623.0 37817.2 38148.4 51482.7 52272.0 53079.5 53697.0 53898.5 7826.7 7897.2 7995.1 8025.8 8285.9 8633.8 10982.3 11525.4 11942.5 11967.8 5508.6 8100.6 8518.5 10655.5 10772.9 10004.8 10661.5 10686.8 10764.2 10980.0 10602.7 10804.2 10831.7 10894.6 11006.3 7831.6 7923.5 8196.4 8209.3 8258.7 9729.0 10804.4 10839.7 10979.7 11039.2 10:10:21 INFO - PROCESS | 19130 | 10:10:21 INFO - PROCESS | 19130 | [#3] mootools.html Cycles:180 Average:5048.61 Median:5256.56 stddev:2771.25 (52.7%) stddev-sans-first:2764.72 10:10:21 INFO - PROCESS | 19130 | Values: 1302.4 1522.4 1551.1 1732.9 1878.3 7140.8 7443.9 7452.7 7628.5 7631.0 7471.9 7624.4 7632.0 7637.0 7650.3 1859.4 1919.5 2159.5 2225.1 2255.7 2239.6 2264.2 2265.3 2266.8 2267.7 2185.5 2205.1 2230.4 2232.6 2236.4 1817.9 2119.1 2155.2 2185.9 2189.5 2173.2 2175.0 2195.5 2197.1 2197.7 7701.8 7717.0 7744.5 7757.5 7762.3 4403.1 4539.0 4546.9 4548.0 4556.0 2745.3 2767.6 2803.3 2814.7 2878.4 880.5 900.4 909.9 912.5 915.9 10363.4 10375.2 10395.2 10395.2 10404.1 4085.7 4222.7 4266.5 4290.5 4298.4 8876.9 8905.5 8912.3 8921.1 8923.1 4534.6 4539.3 4559.1 4564.6 4566.0 3672.2 4019.5 4143.1 4144.9 4178.7 3561.4 3575.2 3617.9 3625.4 3701.6 1208.1 1223.8 1233.5 1236.1 1242.6 707.2 819.4 871.1 899.4 928.3 5200.0 5282.9 5320.7 5410.7 5434.6 907.5 908.7 911.1 913.8 925.5 3714.0 3719.6 3735.1 3763.1 3770.5 9020.2 9459.1 9488.1 9515.1 9532.1 9341.2 9353.5 9369.2 9425.2 9464.3 6982.0 7072.0 7087.8 7120.1 7142.1 5024.2 5091.3 5162.9 5208.2 5230.2 8288.3 8416.2 8496.5 8509.8 8581.8 8357.2 8515.2 8589.7 8628.2 8682.0 5404.5 6113.7 6247.1 6249.5 6338.7 7463.1 7494.7 7516.8 7529.1 7543.3 6660.4 6854.4 6875.5 6966.9 6984.2 6113.2 6146.3 6754.6 6780.6 6818.1 6242.4 6286.1 6311.7 6312.1 6312.7 4324.6 4476.4 4508.4 4522.3 4591.3 4689.2 4703.6 4733.4 4735.8 4740.6 10:10:21 INFO - PROCESS | 19130 | 10:10:21 INFO - PROCESS | 19130 | [#4] prototype.html Cycles:180 Average:4043.34 Median:4547.62 stddev:1155.89 (25.4%) stddev-sans-first:1124.54 10:10:21 INFO - PROCESS | 19130 | Values: 303.9 309.6 314.9 317.7 318.9 4676.5 4752.7 4786.7 4799.7 4843.0 4509.0 4593.3 4600.4 4619.6 4689.0 3610.9 3623.5 3671.4 3708.9 3720.9 3709.5 3723.4 3726.0 3752.1 3756.9 3632.0 3689.2 3720.7 3723.8 3729.9 3699.9 3706.2 3710.3 3731.8 3739.4 3310.8 3311.5 3321.7 3356.2 3359.2 4453.8 4489.6 4503.9 4505.9 4536.5 4130.6 4206.6 4256.1 4277.9 4282.9 4784.9 4832.8 4843.8 4847.0 4850.4 3632.6 3643.5 3644.0 3651.7 3652.3 4843.6 5083.5 5109.2 5142.9 5148.6 3550.2 3551.2 3565.4 3579.5 3585.5 3608.6 3627.8 3633.6 3635.8 3636.8 4134.3 4151.1 4151.7 4152.2 4169.9 4696.9 4880.6 4928.0 4932.5 4947.6 1206.4 1211.8 1211.9 1212.4 1214.2 794.8 831.2 848.0 855.8 858.6 4184.6 4194.7 4205.4 4242.9 4254.3 4879.7 4883.0 4887.6 4909.9 4923.7 4112.8 4174.8 4189.6 4234.6 4236.2 2594.9 2603.5 2610.6 2618.6 2621.8 4514.5 4524.4 4542.2 4621.3 4625.7 4815.8 4905.4 4906.9 4980.9 5005.8 4498.3 4553.0 4558.5 4576.3 4604.3 4832.3 4858.7 4864.6 4870.1 4872.4 4585.4 4730.2 4768.2 4782.8 4805.4 4535.8 4554.0 4584.0 4595.6 4598.1 3466.8 3482.8 3497.0 3524.3 3534.5 4807.9 4849.1 4882.0 4929.3 4951.6 4656.7 4994.8 4998.3 5005.2 5008.8 4986.9 4990.2 5009.4 5023.7 5052.4 4759.8 4927.6 4950.6 4958.4 4960.8 4907.4 4916.7 4954.9 4957.2 5023.7 4839.1 4852.2 4861.3 4865.4 4882.2 10:10:21 INFO - PROCESS | 19130 | 10:10:21 INFO - PROCESS | 19130 | [#5] yui.html Cycles:180 Average:13039.78 Median:4232.26 stddev:14405.26 (340.4%) stddev-sans-first:14415.77 10:10:21 INFO - PROCESS | 19130 | Values: 682.3 748.0 791.6 795.9 814.0 11829.0 11900.3 11909.5 11929.8 12472.1 12759.1 13032.3 13123.7 13125.7 13142.9 873.9 880.2 887.4 887.5 887.5 671.4 849.7 878.9 881.2 885.3 913.3 918.9 920.0 920.4 922.1 707.7 902.7 904.5 904.8 905.7 661.2 674.7 675.8 680.5 681.5 13220.4 13268.8 13270.7 13271.3 13290.6 11778.3 12081.8 12125.3 12229.3 12658.2 11342.8 11344.1 11379.6 11575.1 12087.7 4131.3 4223.4 4241.2 4247.8 4281.7 44320.3 44466.8 44568.0 44879.6 44883.8 10052.6 10303.9 10427.8 10662.8 10735.8 18278.4 18357.5 18359.6 18388.2 18930.5 6801.8 6863.6 6921.9 7008.8 7013.5 3834.0 3853.5 3854.5 3870.7 3966.8 2905.1 3022.4 3024.9 3026.5 3031.1 542.8 550.4 555.7 560.0 564.1 560.8 581.1 599.5 629.3 648.2 7428.0 7479.7 7658.3 7711.8 7823.6 612.3 614.6 617.8 619.1 629.3 3648.7 3653.4 3740.2 3834.6 3850.7 47314.8 49202.5 49246.3 52361.0 52461.5 47711.8 48251.5 48633.8 49080.3 49148.5 43896.3 43902.0 44267.6 44774.6 44950.8 8362.4 8678.2 8684.4 8688.9 8833.3 28603.6 28732.0 29081.9 29381.4 30246.8 36982.4 39060.2 39542.6 39571.4 40007.8 10860.1 11073.4 11286.3 11398.5 11769.8 11604.8 11764.4 12043.3 12254.3 12263.5 11383.7 11990.1 12091.3 12744.0 12753.4 11956.7 12259.3 12270.9 12419.9 12622.2 10318.2 10607.2 10746.4 10899.9 10900.4 9603.7 10076.1 10325.8 10337.1 10733.2 8666.1 8887.6 9138.9 9445.5 9692.1 10:10:21 INFO - PROCESS | 19130 | -------- Summary: end -------- 10:10:21 INFO - PROCESS | 19130 | 10:10:22 INFO - TEST-INFO | 19130: exit 0 10:10:22 INFO - TEST-OK | dromaeo_css | took 1118804ms 10:10:22 INFO - TEST-START | kraken 10:10:22 INFO - operating with platform_type : linux_ 10:10:22 INFO - Initialising browser for kraken test... 10:10:22 INFO - TEST-INFO | started process 19307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvm4dFo/profile http://localhost:37528/getInfo.html) 10:10:26 INFO - PROCESS | 19307 | __metrics Screen width/height:1600/1200 10:10:26 INFO - PROCESS | 19307 | colorDepth:24 10:10:26 INFO - PROCESS | 19307 | Browser inner width/height: 1024/697 10:10:26 INFO - PROCESS | 19307 | __metrics 10:10:27 ERROR - PROCESS | 19307 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:10:28 INFO - TEST-INFO | 19307: exit 0 10:10:28 INFO - Browser initialized. 10:10:28 INFO - Running cycle 1/1 for kraken test... 10:10:28 INFO - TEST-INFO | started process 19388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvm4dFo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:40 INFO - PROCESS | 19388 | RSS: Main: 154292224 10:10:40 INFO - PROCESS | 19388 | 10:10:42 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37528/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:43 INFO - PROCESS | 19388 | RSS: Main: 209727488 10:10:43 INFO - PROCESS | 19388 | 10:10:46 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37528/tests/kraken/driver.html?testName=audio-dft) 10:10:47 INFO - PROCESS | 19388 | RSS: Main: 198402048 10:10:47 INFO - PROCESS | 19388 | 10:10:50 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37528/tests/kraken/driver.html?testName=audio-fft) 10:10:51 INFO - PROCESS | 19388 | RSS: Main: 266403840 10:10:51 INFO - PROCESS | 19388 | 10:10:53 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37528/tests/kraken/driver.html?testName=audio-oscillator) 10:10:53 INFO - PROCESS | 19388 | RSS: Main: 175779840 10:10:53 INFO - PROCESS | 19388 | 10:10:56 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37528/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:56 INFO - PROCESS | 19388 | RSS: Main: 178847744 10:10:56 INFO - PROCESS | 19388 | 10:10:59 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37528/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:00 INFO - PROCESS | 19388 | RSS: Main: 215146496 10:11:00 INFO - PROCESS | 19388 | 10:11:03 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37528/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:04 INFO - PROCESS | 19388 | RSS: Main: 216719360 10:11:04 INFO - PROCESS | 19388 | 10:11:07 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37528/tests/kraken/driver.html?testName=json-parse-financial) 10:11:08 INFO - PROCESS | 19388 | RSS: Main: 216199168 10:11:08 INFO - PROCESS | 19388 | 10:11:09 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37528/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:10 INFO - PROCESS | 19388 | RSS: Main: 204873728 10:11:10 INFO - PROCESS | 19388 | 10:11:12 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37528/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:12 INFO - PROCESS | 19388 | RSS: Main: 207142912 10:11:12 INFO - PROCESS | 19388 | 10:11:15 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37528/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:15 INFO - PROCESS | 19388 | RSS: Main: 217567232 10:11:15 INFO - PROCESS | 19388 | 10:11:18 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:19 INFO - PROCESS | 19388 | RSS: Main: 224456704 10:11:19 INFO - PROCESS | 19388 | 10:11:22 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:22 INFO - PROCESS | 19388 | RSS: Main: 220483584 10:11:22 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | Cycle 1(1): loaded http://localhost:37528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37528/tests/kraken/driver.html?testName=ai-astar) 10:11:24 INFO - PROCESS | 19388 | RSS: Main: 265457664 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | __start_tp_report 10:11:24 INFO - PROCESS | 19388 | _x_x_mozilla_page_load 10:11:24 INFO - PROCESS | 19388 | _x_x_mozilla_page_load_details 10:11:24 INFO - PROCESS | 19388 | |i|pagename|runs| 10:11:24 INFO - PROCESS | 19388 | |0;ai-astar;113;106;112;111;112;112;111;112;111;114 10:11:24 INFO - PROCESS | 19388 | |1;audio-beat-detection;154;133;152;173;131;151;162;136;214;139 10:11:24 INFO - PROCESS | 19388 | |2;audio-dft;162;161;161;162;161;161;161;161;162;161 10:11:24 INFO - PROCESS | 19388 | |3;audio-fft;77;76;77;126;77;75;78;75;134;77 10:11:24 INFO - PROCESS | 19388 | |4;audio-oscillator;93;93;124;92;92;93;133;92;93;124 10:11:24 INFO - PROCESS | 19388 | |5;imaging-gaussian-blur;117;116;117;117;116;116;116;117;118;117 10:11:24 INFO - PROCESS | 19388 | |6;imaging-darkroom;145;145;146;145;146;146;146;146;145;146 10:11:24 INFO - PROCESS | 19388 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 10:11:24 INFO - PROCESS | 19388 | |8;json-parse-financial;66;66;66;66;66;66;66;89;65;64 10:11:24 INFO - PROCESS | 19388 | |9;json-stringify-tinderbox;64;65;64;64;65;64;64;64;64;65 10:11:24 INFO - PROCESS | 19388 | |10;stanford-crypto-aes;81;81;82;82;87;84;83;83;93;85 10:11:24 INFO - PROCESS | 19388 | |11;stanford-crypto-ccm;136;141;139;139;128;147;130;131;186;142 10:11:24 INFO - PROCESS | 19388 | |12;stanford-crypto-pbkdf2;175;171;175;172;173;171;177;176;175;171 10:11:24 INFO - PROCESS | 19388 | |13;stanford-crypto-sha256-iterative;68;67;68;68;68;67;67;68;66;66 10:11:24 INFO - PROCESS | 19388 | __end_tp_report 10:11:24 INFO - PROCESS | 19388 | __start_cc_report 10:11:24 INFO - PROCESS | 19388 | _x_x_mozilla_cycle_collect,1859 10:11:24 INFO - PROCESS | 19388 | __end_cc_report 10:11:24 INFO - PROCESS | 19388 | __startTimestamp1462554684651__endTimestamp 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | ------- Summary: start ------- 10:11:24 INFO - PROCESS | 19388 | Number of tests: 14 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.12 (1.9%) stddev-sans-first:2.17 10:11:24 INFO - PROCESS | 19388 | Values: 113.0 106.0 112.0 111.0 112.0 112.0 111.0 112.0 111.0 114.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:153.00 stddev:24.84 (16.2%) stddev-sans-first:26.35 10:11:24 INFO - PROCESS | 19388 | Values: 154.0 133.0 152.0 173.0 131.0 151.0 162.0 136.0 214.0 139.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 10:11:24 INFO - PROCESS | 19388 | Values: 162.0 161.0 161.0 162.0 161.0 161.0 161.0 161.0 162.0 161.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#3] audio-fft Cycles:10 Average:87.20 Median:77.00 stddev:22.66 (29.4%) stddev-sans-first:23.73 10:11:24 INFO - PROCESS | 19388 | Values: 77.0 76.0 77.0 126.0 77.0 75.0 78.0 75.0 134.0 77.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:92.50 stddev:16.82 (18.2%) stddev-sans-first:17.45 10:11:24 INFO - PROCESS | 19388 | Values: 93.0 93.0 124.0 92.0 92.0 93.0 133.0 92.0 93.0 124.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:11:24 INFO - PROCESS | 19388 | Values: 117.0 116.0 117.0 117.0 116.0 116.0 116.0 117.0 118.0 117.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:11:24 INFO - PROCESS | 19388 | Values: 145.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:11:24 INFO - PROCESS | 19388 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:66.00 stddev:7.41 (11.2%) stddev-sans-first:7.82 10:11:24 INFO - PROCESS | 19388 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 66.0 89.0 65.0 64.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 10:11:24 INFO - PROCESS | 19388 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 65.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.63 (4.4%) stddev-sans-first:3.68 10:11:24 INFO - PROCESS | 19388 | Values: 81.0 81.0 82.0 82.0 87.0 84.0 83.0 83.0 93.0 85.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:140.00 stddev:16.59 (11.8%) stddev-sans-first:17.46 10:11:24 INFO - PROCESS | 19388 | Values: 136.0 141.0 139.0 139.0 128.0 147.0 130.0 131.0 186.0 142.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:175.00 stddev:2.27 (1.3%) stddev-sans-first:2.35 10:11:24 INFO - PROCESS | 19388 | Values: 175.0 171.0 175.0 172.0 173.0 171.0 177.0 176.0 175.0 171.0 10:11:24 INFO - PROCESS | 19388 | 10:11:24 INFO - PROCESS | 19388 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 10:11:24 INFO - PROCESS | 19388 | Values: 68.0 67.0 68.0 68.0 68.0 67.0 67.0 68.0 66.0 66.0 10:11:24 INFO - PROCESS | 19388 | -------- Summary: end -------- 10:11:24 INFO - PROCESS | 19388 | 10:11:25 INFO - TEST-INFO | 19388: exit 0 10:11:25 INFO - TEST-OK | kraken | took 63455ms 10:11:25 INFO - SUITE-END | took 1182s 10:11:25 INFO - Completed test suite (00:19:42) 10:11:25 INFO - javascript benchmark 10:11:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2613.8170328077035, 2625.973740262597, 2669.039145907473, 2680.504106740252, 2681.4100897802477, 4622.5377462253755, 4646.674732768707, 4674.182018146827, 4693.178693728601, 4719.009008108297, 4727.90544189116, 4741.762911854411, 4777.8805529861775, 4809.182438985372, 4829.22732362822, 4290.635295999836, 4317.0, 4326.156399502099, 4449.443819522559, 4454.754988475633, 4410.911781764363, 4411.647068234533, 4430.025394413224, 4448.466184057917, 4460.50934397216, 4201.810918508674, 4246.745195288293, 4357.237483440417, 4392.29723244281, 4401.757903315316, 4284.250256205151, 4292.849750258726, 4299.849505267332, 4300.13997200558, 4323.632491238249, 4315.633171180422, 4337.97831010846, 4342.934855977162, 4380.693351465398, 4387.341898715218, 4496.213162696547, 4608.193566125915, 4692.41344831896, 4694.600958918496, 4706.788194531255, 5052.898942021139, 5139.486051394868, 5140.1004824155625, 5140.563052140536, 5145.588352931756, 5101.438841727407, 5119.872003199913, 5132.178851383761, 5146.459621739701, 5165.405978312467, 4578.931316030262, 4592.7014744041535, 4605.562471565196, 4742.668013239075, 4799.18413869643, 5100.4899510049445, 5164.25118357836, 5175.430702622709, 5176.767045482962, 5179.741012949337, 4920.704757714549, 4961.7519124044375, 4971.204607262821, 4971.975140124277, 4974.328465657162, 4927.9507204927495, 4976.576990955809, 5026.924596130988, 5086.92369614456, 5090.974545127325, 5010.023045506091, 5059.114654935372, 5078.619103567247, 5090.0583392072585, 5115.1559992600805, 5038.420581633159, 5039.77321020555, 5046.142155833517, 5067.4932506749765, 5077.873053173626, 4235.195312890541, 4258.638015768633, 4269.786510674454, 4305.009847735038, 4383.1452866691325, 3771.2834561433788, 3785.1104990327253, 3788.905277368088, 3828.0238539172333, 3838.3666694995013, 4362.476502819619, 4369.453818272716, 4373.343998400265, 4410.2282100632265, 4414.359917811899, 4962.454130045692, 5003.424606170264, 5045.47022562633, 5061.291419201315, 5077.0, 4342.2835232186335, 4362.018545827227, 4364.8254069837485, 4366.14860102277, 4395.582419670126, 4599.977000115045, 4604.861854144381, 4606.953930460652, 4613.746243956548, 4657.74382408964, 4580.312953057068, 4686.789094490756, 4741.620670346433, 4742.928856067093, 4750.5249475052215, 5071.416787069535, 5081.745912704276, 5094.0, 5101.566366858859, 5152.355955505562, 4579.175748365193, 4736.928946065881, 4744.857654270378, 4745.169595320874, 4797.4482934462985, 4872.853814385574, 4872.926906096341, 4897.338859254098, 4924.384451943507, 4928.778204980713, 4917.926231106608, 4964.751762411937, 4965.28003439492, 4968.577670897869, 4984.576311013604, 4730.219513780187, 4856.247281671346, 4967.3542439482635, 4975.0796102721115, 5028.069807085701, 4881.145799485005, 4892.779824907817, 4913.115639184981, 4937.382827146606, 4984.0, 4827.675357476665, 4845.515448455127, 4899.069176856386, 4900.779464924016, 4902.509749025069, 4758.595519380891, 4862.051899879631, 4920.384951881015, 4938.234573641092, 4949.9257511138085, 4686.390769199982, 4714.057188562233, 4739.099571081483, 4739.360186374795, 4763.595094416874], "value": 4633.470293450677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4543365652147, 602.217117746929, 607.7811987684436, 611.7828170999298, 615.2893408113628, 27909.581356279647, 30514.389712205742, 30521.694783052164, 30569.694303056935, 30641.38717225657, 30313.242168945733, 43641.34537981933, 44512.0, 44556.0, 48378.0, 7961.0, 8075.232852878967, 8077.192280771935, 8079.394045446586, 8082.838343233132, 7973.800654983614, 8037.196280371945, 8050.637721302555, 8054.758357249292, 8057.315128214109, 8031.0, 8083.0, 8089.393295502831, 8090.595470226494, 8098.676052957874, 8004.319632831187, 8038.0, 8059.476134051268, 8059.717909873127, 8062.0, 7907.881381779278, 7972.0832104308165, 7972.681092756283, 7980.241877021674, 7983.560904150328, 40628.796856015826, 40806.0, 40920.0, 40923.590764092274, 40952.38571421401, 3230.8707651693903, 3492.7904325740283, 3545.3795585772646, 3802.448644946495, 4056.067104565937, 27175.1847444577, 27271.590926136123, 27935.860320698266, 32057.0, 32089.0, 3373.0, 3407.369636617234, 3416.9829150854334, 3425.2635683328203, 3576.0763880232303, 263373.0, 263388.0, 264896.0, 265252.9999999981, 265565.0, 30301.545476817864, 30988.53517197244, 60905.39094609086, 61923.69038154781, 61987.070193947126, 36286.63713362833, 36384.45423318652, 36453.81773091118, 36467.27065458676, 36490.0, 14784.704305914036, 14932.776008359884, 14942.0, 14946.925265373604, 14947.1779052151, 12284.508619655293, 12318.938405307916, 12422.503099875903, 12427.502899884084, 12428.62714118578, 8336.166383361737, 8354.58227088643, 8422.53676047811, 8428.410011299151, 8478.3641226907, 3240.643529211785, 3246.610406751205, 3250.0737289872272, 3313.801171929692, 3328.783629064103, 931.1619542411748, 950.496236994394, 1018.2363227579316, 1018.7962407518526, 1044.6657069737612, 29190.27024324409, 30010.0, 32374.514382284284, 33773.32453350919, 33841.64633414636, 998.5955687946393, 1038.2628333883029, 1041.4376236832027, 1046.1473898772476, 1075.956961721538, 15395.538133856002, 15528.145951972523, 15812.086804054949, 15922.522324330288, 15944.521664350088, 383543.0, 388348.0, 389277.0, 389650.0, 391210.0, 51955.48044519582, 52512.73743631257, 52583.21125183125, 52685.47314526882, 52690.73654631779, 1173.0674114079327, 1215.7568486302598, 1295.9999999999811, 1324.1723922548408, 1352.6212660455087, 29301.41397172087, 29787.851060745423, 30173.09480715582, 30839.537406938463, 30862.0, 50055.74972125116, 51889.22166167586, 51974.740126299126, 57060.71469642625, 57127.42872571221, 324455.0, 329327.0, 329329.0, 330297.0, 330574.0, 33668.326633466706, 39423.408648869714, 39919.0, 40270.79864600658, 40435.595644043184, 44323.11353772971, 44785.0, 44840.32739508845, 45120.54879451163, 45333.320000200685, 36790.44814327734, 37878.62121378861, 38170.618293816704, 38652.6134738649, 38719.0, 37522.437163443115, 37708.2458350837, 38029.61970380371, 38376.6162338373, 38734.418983715834, 29471.557926631547, 32975.175620609676, 38547.229055419295, 38894.80552597219, 42156.57843421649, 32935.835320823244, 34076.488852667724, 34250.314993700486, 34597.65402345944, 34829.477557836144, 25727.485450290515, 26066.609000864624, 26316.4736705261, 26391.20826375212, 26454.677266137], "value": 17480.736802308405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.9532558430197, 380.14846743295027, 385.48152734572, 393.95469521005055, 404.2440636010659, 16140.515784526453, 17063.74404383932, 17751.3136252056, 17886.195121219545, 17916.55208619785, 17081.316747330093, 17353.0, 17480.912595437007, 18008.63982720345, 18030.18864151113, 5137.640365174449, 5329.546988505982, 5362.705051222181, 5381.515663590276, 5386.245925570423, 3734.5518537775506, 3806.3338915689783, 3899.161680238748, 6083.300420451638, 6243.937560624404, 6161.075838624198, 6179.474744646711, 6195.0, 6198.938010619881, 6208.441240288374, 6143.354947730513, 6155.969220153893, 6157.0, 6157.722902469377, 6164.784232551884, 3126.1559378967777, 4996.650234483587, 5321.414644389114, 5326.0, 5433.130699088167, 20189.293374731813, 20337.084831182634, 20556.897215513975, 20690.275840345515, 20707.792922070737, 2051.8974051297378, 2073.2121793718443, 2080.625487412265, 2085.8539902206853, 2093.8324934005245, 12933.248392426953, 13158.078934474495, 13231.0, 13485.865141348559, 13950.093243939213, 1741.5646088477881, 1790.1407324484321, 1819.672458957387, 1841.558026073746, 1861.525311045688, 55277.894442111334, 58240.12639810406, 61336.0, 63671.36328636747, 63695.999999999534, 10218.386896786216, 10399.740006499898, 10448.52981615829, 10518.0, 10597.0, 14433.566992990227, 14475.78286325706, 14487.20320382389, 14503.782443263359, 14509.0, 7233.0, 7715.614219289013, 7772.222777722295, 7840.607969601497, 7888.368930485547, 7391.0, 7403.370713489306, 7552.093748750075, 7559.470837041465, 7571.848563028709, 4369.853705332156, 4437.622802061861, 4461.843835465808, 4493.955060449353, 4583.495815460296, 1834.2662934826176, 1840.0, 1860.702287633972, 1878.7651543557056, 1898.0604600722731, 886.7561420609384, 888.7955770172767, 904.3488688144525, 935.6678379175431, 960.5437417226901, 16480.0935948524, 16908.830911690973, 16968.321267149175, 17443.21505532254, 17669.55826104332, 852.9872051919226, 885.0, 890.1276748786225, 920.5719340506563, 933.673214374977, 9503.904960950302, 9570.425774453555, 9710.126088652056, 9777.217822574177, 9793.167580755715, 398959.0, 404192.0, 404774.0, 408829.0, 409123.0, 78116.2188378109, 81572.0, 82750.58624706838, 84721.57639211764, 85631.0, 938.7324612485409, 943.3820847344863, 965.1120968708805, 966.7679756858304, 969.3941286695815, 15144.54566363011, 15460.690786184437, 15481.612959676098, 15831.0, 15838.9208053959, 35862.46206306855, 36381.81809090938, 37623.0, 37817.24365512729, 38148.42777358397, 51482.742586288325, 52272.0, 53079.469205307454, 53697.0, 53898.461015389345, 7826.726064587712, 7897.1707970662255, 7995.080565734782, 8025.759227223192, 8285.917140828757, 8633.784155396166, 10982.341059536453, 11525.366104863977, 11942.462589183682, 11967.76064478723, 5508.614396992172, 8100.622894107898, 8518.531480768617, 10655.520501577603, 10772.946135269274, 10004.849442314227, 10661.520231589751, 10686.786264274515, 10764.192685548458, 10980.0, 10602.681919542427, 10804.189685773441, 10831.675049748204, 10894.61868834587, 11006.339619622848, 7831.569263690551, 7923.534146182975, 8196.42625016243, 8209.343252539902, 8258.710945117133, 9729.0, 10804.405757683402, 10839.729006774578, 10979.670609881716, 11039.172062095535], "value": 8469.80288609813, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.4464602543917, 1522.3986525322498, 1551.1468692219278, 1732.8786984911062, 1878.3144152384375, 7140.785776426709, 7443.851122977537, 7452.701891924324, 7628.466007379472, 7630.961845190766, 7471.850562988737, 7624.390048796097, 7631.961840190806, 7637.045369328834, 7650.34972027377, 1859.414284500378, 1919.4529559075665, 2159.4601349662585, 2225.1433198218683, 2255.740589832174, 2239.6192647250004, 2264.1735766445295, 2265.2864347730497, 2266.784655457729, 2267.6938613287243, 2185.5082606413507, 2205.106931692667, 2230.397792595998, 2232.586971410286, 2236.39617303328, 1817.9181936812809, 2119.088791819517, 2155.224119317045, 2185.9234926777485, 2189.4635814225617, 2173.2393662218255, 2175.0321107107343, 2195.5169862630196, 2197.110170380998, 2197.7362716473967, 7701.768946931545, 7717.0, 7744.457887947846, 7757.456978011542, 7762.340201082915, 4403.075354175627, 4538.9546104539195, 4546.8635940921495, 4547.954520454786, 4555.954440455586, 2745.272502786763, 2767.6125342452074, 2803.271149501124, 2814.7185281471893, 2878.3955369372457, 880.4893161966045, 900.3787386703154, 909.899911009795, 912.543728135932, 915.9313051521096, 10363.37819730811, 10375.221858360654, 10395.220358473145, 10395.220358473145, 10404.063634272876, 4085.6527195188146, 4222.683298752606, 4266.466691663542, 4290.549492303326, 4298.398224248608, 8876.911230887737, 8905.51019693923, 8912.287017038621, 8921.107889211027, 8923.063078376807, 4534.569215924482, 4539.296409056601, 4559.088182363541, 4564.6348292136545, 4565.977170114128, 3672.2288319452678, 4019.537753158424, 4143.109231515178, 4144.937825932613, 4178.7283826551175, 3561.3589553880033, 3575.2313252650806, 3617.94573081404, 3625.4018087015347, 3701.648898152155, 1208.1422190245025, 1223.7613665335175, 1233.5065973610629, 1236.07912105482, 1242.5526810348267, 707.1514182980444, 819.4264015189273, 871.1027641529236, 899.3794281945437, 928.2991341537231, 5199.974000129975, 5282.947170528246, 5320.680759154463, 5410.702411367334, 5434.565234781208, 907.491804589432, 908.7228395339484, 911.125319693102, 913.8263729891299, 925.5233554719325, 3713.9814300928324, 3719.6466335698065, 3735.1409175889153, 3763.096856754359, 3770.547534295902, 9020.233280171127, 9459.148676619137, 9488.098630630078, 9515.096065873731, 9532.142107210246, 9341.159295663423, 9353.485558294358, 9369.156775890202, 9425.151736343762, 9464.337496375325, 6981.965090174516, 7072.045273887959, 7087.82280442993, 7120.074390329224, 7142.142942846892, 5024.171011783161, 5091.287219789158, 5162.870928226825, 5208.24480450325, 5230.163173892159, 8288.336933045463, 8416.242538171595, 8496.53269070207, 8509.829803403773, 8581.785455363417, 8357.164283571594, 8515.233628973423, 8589.742307730528, 8628.180322869317, 8681.956590217262, 5404.54061404785, 6113.694315284129, 6247.12540244357, 6249.50003999688, 6338.746450141943, 7463.067116610424, 7494.662740176815, 7516.8496630066, 7529.134149572869, 7543.283388078124, 6660.433863121689, 6854.417374523221, 6875.48433867472, 6966.930330696831, 6984.231734509099, 6113.205283313141, 6146.262448506208, 6754.560953538201, 6780.627065511247, 6818.113645226089, 6242.375762423721, 6286.119943208046, 6311.715972781328, 6312.116303717391, 6312.7159277833525, 4324.632406245504, 4476.350929115325, 4508.368828363966, 4522.3442600823355, 4591.265397536378, 4689.202835517902, 4703.647226457961, 4733.431988161305, 4735.763211839326, 4740.597049250852], "value": 4104.778788062775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.9149038269284, 309.5867017531595, 314.8897885739991, 317.74739082429465, 318.86926360192325, 4676.462206846214, 4752.667313288062, 4786.736729479877, 4799.712017278961, 4842.95157048429, 4508.954910450894, 4593.333966574844, 4600.355950166971, 4619.58423741864, 4689.038747056854, 3610.855565777379, 3623.5108260384773, 3671.430928206132, 3708.8701895433665, 3720.8883733488037, 3709.517762690846, 3723.4042553191493, 3726.0, 3752.08074021865, 3756.8685096021645, 3632.0, 3689.1514951561157, 3720.683741881943, 3723.813809309537, 3729.936967964131, 3699.9290588811223, 3706.184639379332, 3710.3321402147603, 3731.776093434389, 3739.439084137374, 3310.817905015223, 3311.4867195584725, 3321.651226621194, 3356.2448449099, 3359.160209947513, 4453.752949174236, 4489.6408287336935, 4503.860666183569, 4505.932411013838, 4536.455625324949, 4130.586941305875, 4206.642435392995, 4256.127493863751, 4277.871663850089, 4282.850100246507, 4784.904301913977, 4832.830850920201, 4843.75781210938, 4847.0, 4850.417949846006, 3632.5822530408814, 3643.508126402928, 3643.9635603643887, 3651.7443778935485, 3652.3337963286685, 4843.612510999147, 5083.491650834924, 5109.233614957749, 5142.894277730306, 5148.588112950993, 3550.218951830593, 3551.2187318789825, 3565.35823551758, 3579.46308053794, 3585.515955346047, 3608.585012723518, 3627.8004709741217, 3633.5821380541574, 3635.8000309982676, 3636.8363423646, 4134.276501612206, 4151.086760912594, 4151.73013754105, 4152.190322887069, 4169.854055108057, 4696.882577935579, 4880.585150262267, 4927.975360123177, 4932.457429682732, 4947.604191664658, 1206.390772659801, 1211.8303437518755, 1211.8606360268682, 1212.42409855318, 1214.1622280626339, 794.7734895554739, 831.2311112221292, 847.9745607631781, 855.8416692911832, 858.5707146426787, 4184.560621134798, 4194.6853985951175, 4205.411242426063, 4242.851500197478, 4254.255505286563, 4879.658423910292, 4882.975585122052, 4887.560119589183, 4909.87725306863, 4923.679960802537, 4112.814923328458, 4174.7893110997475, 4189.581041895786, 4234.55537168599, 4236.195122926634, 2594.8962041518507, 2603.5053339865367, 2610.577235406708, 2618.5679362904907, 2621.84268943864, 4514.480834704051, 4524.366588677588, 4542.205114105019, 4621.329907163443, 4625.653076019312, 4815.807367705253, 4905.351110400416, 4906.901861962812, 4980.9252861207115, 5005.774740136702, 4498.302763071729, 4553.043860789271, 4558.544145585482, 4576.290674945389, 4604.283472751093, 4832.323474713473, 4858.684185527929, 4864.586510146677, 4870.1233777920315, 4872.43966943806, 4585.358049872953, 4730.2431610942085, 4768.189407800752, 4782.7847746850775, 4805.351277577623, 4535.773211339354, 4553.977230113828, 4583.966109823334, 4595.575371634804, 4598.149342371538, 3466.826658667006, 3482.773619714812, 3497.0, 3524.295140971867, 3534.469829525489, 4807.870150514556, 4849.078675051729, 4882.0, 4929.338157394966, 4951.603871690329, 4656.67403281767, 4994.775235114356, 4998.3252260945765, 5005.174146265971, 5008.799648014185, 4986.902881366093, 4990.226514890198, 5009.373828271466, 5023.673461225008, 5052.368453943257, 4759.785809638505, 4927.630427717864, 4950.603951683928, 4958.355413796184, 4960.751962401793, 4907.411110666742, 4916.655834091579, 4954.900901982012, 4957.231629097496, 5023.723695196799, 4839.056384005085, 4852.199387101089, 4861.343718598086, 4865.391826021747, 4882.218844984785], "value": 3681.2021787019494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.3381320119483, 747.960335134164, 791.608153963788, 795.9482633628813, 813.9837203255935, 11829.0, 11900.345480998552, 11909.523619055228, 11929.7614047719, 12472.126951113425, 12759.106862519628, 13032.283224422654, 13123.6719082023, 13125.737485250313, 13142.868571314284, 873.8863947686792, 880.1506546182932, 887.3611000079965, 887.4586502233665, 887.4719541872576, 671.3521451799013, 849.7026040885702, 878.9340799440035, 881.2245224202693, 885.2696525366566, 913.3241401362977, 918.9448633082003, 920.0247737398346, 920.4017388697333, 922.1193759959257, 707.7239876448137, 902.702108304258, 904.5341649050777, 904.751193421811, 905.6965916418008, 661.163628010567, 674.6559254780049, 675.8141511084442, 680.4590350671228, 681.4820736240443, 13220.405081771343, 13268.800967985488, 13270.73458530824, 13271.270080145589, 13290.601281961557, 11778.293302401884, 12081.758364832742, 12125.333106679129, 12229.327386993711, 12658.240505569695, 11342.773144537146, 11344.092472602171, 11379.601713940056, 11575.073994080538, 12087.697807554794, 4131.256135897091, 4223.36649502574, 4241.151769646052, 4247.766372849492, 4281.678874084425, 44320.3351949721, 44466.77766611178, 44568.0, 44879.55120448819, 44883.77558112221, 10052.64815731446, 10303.896961030443, 10427.843582346271, 10662.786744265071, 10735.785284294427, 18278.360257390927, 18357.541061473305, 18359.63280734378, 18388.17253223608, 18930.52673683169, 6801.820191378929, 6863.622500762406, 6921.861562768817, 7008.789736307817, 7013.473989450812, 3834.0223243073397, 3853.537575490903, 3854.4989151410136, 3870.748401353903, 3966.8214930328204, 2905.099419180061, 3022.3804120155314, 3024.894128705485, 3026.546018097303, 3031.10582378199, 542.8371488553497, 550.3918170421706, 555.7249161665002, 560.017169866881, 564.0552075273899, 560.7560711090689, 581.0847914534625, 599.4574909706722, 629.26061877294, 648.2156590525423, 7428.0, 7479.663415146223, 7658.349040331635, 7711.768646940601, 7823.647935842901, 612.3264409149899, 614.6435067660746, 617.8362733875437, 619.071392910634, 629.3391938464686, 3648.689861361814, 3653.4337177737493, 3740.214554943438, 3834.559025712079, 3850.7497012694084, 47314.763426182646, 49202.50797492051, 49246.261306080436, 52361.0, 52461.475385245656, 47711.761441192575, 48251.5174848254, 48633.756831215615, 49080.26379604309, 49148.508514915105, 43896.3415548767, 43902.0, 44267.55732442634, 44774.552254477036, 44950.77524612356, 8362.414630975773, 8678.218960293603, 8684.39209255346, 8688.91311086881, 8833.293336532934, 28603.570946436237, 28731.994380196593, 29081.85459072691, 29381.41237175287, 30246.84876575603, 36982.44526332054, 39060.218795624496, 39542.60457395389, 39571.40642890416, 40007.799961001176, 10860.076893464144, 11073.390963496762, 11286.322820630789, 11398.544058237909, 11769.823452648388, 11604.767904642029, 11764.411779411166, 12043.277403355827, 12254.264744115026, 12263.509459621871, 11383.715407114889, 11990.100742444525, 12091.274523528617, 12744.0441966851, 12753.426095825525, 11956.684764676053, 12259.264444133381, 12270.877291226974, 12419.93790031044, 12622.242665440102, 10318.226133039901, 10607.151427885596, 10746.355218686904, 10899.891001090205, 10900.40047797347, 9603.711888643353, 10076.09315161639, 10325.793484130425, 10337.121344685786, 10733.19501037441, 8666.090060543553, 8887.600057997277, 9138.862917056382, 9445.527723613654, 9692.079252471003], "value": 6198.793587846215, "unit": "score"}], "name": "dromaeo_css", "value": 6328.920816954497, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 111.0, 112.0, 112.0, 111.0, 112.0, 111.0, 114.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 152.0, 173.0, 131.0, 151.0, 162.0, 136.0, 214.0, 139.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 126.0, 77.0, 75.0, 78.0, 75.0, 134.0, 77.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 124.0, 92.0, 92.0, 93.0, 133.0, 92.0, 93.0, 124.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 89.0, 65.0, 64.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 82.0, 87.0, 84.0, 83.0, 83.0, 93.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 139.0, 139.0, 128.0, 147.0, 130.0, 131.0, 186.0, 142.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 175.0, 172.0, 173.0, 171.0, 177.0, 176.0, 175.0, 171.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 66.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1573.6999999999998, "alertThreshold": 2.0}]} 10:11:25 INFO - Return code: 0 10:11:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:11:25 ERROR - # TBPL SUCCESS # 10:11:25 INFO - Running post-action listener: _resource_record_post_action 10:11:25 INFO - ##### 10:11:25 INFO - ##### Finished run-tests step (success) 10:11:25 INFO - ##### 10:11:25 INFO - Running post-run listener: _resource_record_post_run 10:11:27 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 16384; Write bytes: 519438336; Read time: 376; Write time: 562260 10:11:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 234790912; Read time: 188; Write time: 297824 10:11:27 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 284647424; Read time: 188; Write time: 264436 10:11:27 INFO - Running post-run listener: _upload_blobber_files 10:11:27 INFO - Blob upload gear active. 10:11:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:27 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 10:11:27 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'] 10:11:27 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 10:11:27 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:28 INFO - (blobuploader) - INFO - Done attempting. 10:11:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:29 INFO - (blobuploader) - INFO - Done attempting. 10:11:29 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:29 INFO - Return code: 0 10:11:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e1b8acbc479cb133aeb5ca89e0fe1154a5b2d0283ab3d2301b7951b0f78958419d1c1e6d36514b4b71db71be071b1c293b2c2721a3a8bfe00cd44f748772d80e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e8d3404effefe72443a0345300238d936907b8545686fe4e919dd454538909f789b22a40bea02b482e04dbfe452ef30d50424ab60588d554185d0e21b772f06"} 10:11:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:29 INFO - Contents: 10:11:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e1b8acbc479cb133aeb5ca89e0fe1154a5b2d0283ab3d2301b7951b0f78958419d1c1e6d36514b4b71db71be071b1c293b2c2721a3a8bfe00cd44f748772d80e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e8d3404effefe72443a0345300238d936907b8545686fe4e919dd454538909f789b22a40bea02b482e04dbfe452ef30d50424ab60588d554185d0e21b772f06"} 10:11:29 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:29 INFO - Copying logs to upload dir... 10:11:29 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.464040 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-06 10:11:29.296084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 10:11:29.300029) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330 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/e1b8acbc479cb133aeb5ca89e0fe1154a5b2d0283ab3d2301b7951b0f78958419d1c1e6d36514b4b71db71be071b1c293b2c2721a3a8bfe00cd44f748772d80e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e8d3404effefe72443a0345300238d936907b8545686fe4e919dd454538909f789b22a40bea02b482e04dbfe452ef30d50424ab60588d554185d0e21b772f06"} build_url:https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/SKKT6JZUSBS8IeYlwbfJHg/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/e1b8acbc479cb133aeb5ca89e0fe1154a5b2d0283ab3d2301b7951b0f78958419d1c1e6d36514b4b71db71be071b1c293b2c2721a3a8bfe00cd44f748772d80e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e8d3404effefe72443a0345300238d936907b8545686fe4e919dd454538909f789b22a40bea02b482e04dbfe452ef30d50424ab60588d554185d0e21b772f06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 10:11:29.325915) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:11:29.326501) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1462553220.533629-1545837330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 10:11:29.411550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 10:11:29.411896) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 10:11:29.412205) ========= ========= Total master_lag: 0.18 =========