builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1469613418.17 results: success (0) buildid: 20160727024013 builduid: b7268bd672e540e39380a29ff2074b07 revision: 80afb86a5a171430c5d687f7fd697d809505fda3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:58.174208) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:58.174613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:58.174880) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:58.204713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:58.205014) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 02:56:58-- 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% 222M=0s 2016-07-27 02:56:58 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122198 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:58.340397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:58.340665) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014982 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:58.392484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:58.392831) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80afb86a5a171430c5d687f7fd697d809505fda3 --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 80afb86a5a171430c5d687f7fd697d809505fda3 --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=8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 02:56:58,898 truncating revision to first 12 chars 2016-07-27 02:56:58,898 Setting DEBUG logging. 2016-07-27 02:56:58,898 attempt 1/10 2016-07-27 02:56:58,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80afb86a5a17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 02:56:59,201 unpacking tar archive at: fx-team-80afb86a5a17/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638423 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:59.048458) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:59.048746) ========= script_repo_revision: 80afb86a5a171430c5d687f7fd697d809505fda3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:59.049132) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:59.049391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 02:56:59.059813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-27 02:56:59.060164) ========= /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=8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:56:59 INFO - MultiFileLogger online at 20160727 02:56:59 in /builds/slave/test 02:56:59 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 02:56:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:56:59 INFO - {'append_to_log': False, 02:56:59 INFO - 'base_work_dir': '/builds/slave/test', 02:56:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:56:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:56:59 INFO - 'branch': 'Fx-Team-Non-PGO', 02:56:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:56:59 INFO - 'config_files': ('talos/linux_config.py',), 02:56:59 INFO - 'default_actions': ('clobber', 02:56:59 INFO - 'read-buildbot-config', 02:56:59 INFO - 'download-and-extract', 02:56:59 INFO - 'populate-webroot', 02:56:59 INFO - 'create-virtualenv', 02:56:59 INFO - 'install', 02:56:59 INFO - 'run-tests'), 02:56:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:56:59 INFO - 'download_minidump_stackwalk': True, 02:56:59 INFO - 'download_symbols': 'ondemand', 02:56:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:56:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:56:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:56:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:56:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:56:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:56:59 INFO - 'installer_path': 'installer.exe', 02:56:59 INFO - 'log_level': 'info', 02:56:59 INFO - 'log_name': 'talos', 02:56:59 INFO - 'log_to_console': True, 02:56:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:56:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:56:59 INFO - 'opt_config_files': (), 02:56:59 INFO - 'pip_index': False, 02:56:59 INFO - 'sps_profile': False, 02:56:59 INFO - 'sps_profile_interval': 0, 02:56:59 INFO - 'suite': 'dromaeojs', 02:56:59 INFO - 'system_bits': '32', 02:56:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:56:59 INFO - 'title': 'talos-linux64-ix-001', 02:56:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:56:59 INFO - 'use_talos_json': True, 02:56:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:56:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:56:59 INFO - 'work_dir': 'build'} 02:56:59 INFO - [mozharness: 2016-07-27 09:56:59.658136Z] Running clobber step. 02:56:59 INFO - Running pre-action listener: _resource_record_pre_action 02:56:59 INFO - Running main action method: clobber 02:56:59 INFO - rmtree: /builds/slave/test/build 02:56:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:57:00 INFO - Running post-action listener: _resource_record_post_action 02:57:00 INFO - [mozharness: 2016-07-27 09:57:00.149861Z] Finished clobber step (success) 02:57:00 INFO - [mozharness: 2016-07-27 09:57:00.149961Z] Running read-buildbot-config step. 02:57:00 INFO - Running pre-action listener: _resource_record_pre_action 02:57:00 INFO - Running main action method: read_buildbot_config 02:57:00 INFO - Using buildbot properties: 02:57:00 INFO - { 02:57:00 INFO - "project": "", 02:57:00 INFO - "product": "firefox", 02:57:00 INFO - "script_repo_revision": "production", 02:57:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:57:00 INFO - "repository": "", 02:57:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:57:00 INFO - "buildid": "20160727024013", 02:57:00 INFO - "pgo_build": "False", 02:57:00 INFO - "basedir": "/builds/slave/test", 02:57:00 INFO - "buildnumber": 1829, 02:57:00 INFO - "slavename": "talos-linux64-ix-001", 02:57:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:57:00 INFO - "platform": "ubuntu64_hw", 02:57:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:57:00 INFO - "branch": "fx-team", 02:57:00 INFO - "repo_path": "integration/fx-team", 02:57:00 INFO - "revision": "80afb86a5a171430c5d687f7fd697d809505fda3", 02:57:00 INFO - "stage_platform": "linux64", 02:57:00 INFO - "builduid": "b7268bd672e540e39380a29ff2074b07", 02:57:00 INFO - "slavebuilddir": "test" 02:57:00 INFO - } 02:57:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:57:00 INFO - Running post-action listener: _resource_record_post_action 02:57:00 INFO - [mozharness: 2016-07-27 09:57:00.152381Z] Finished read-buildbot-config step (success) 02:57:00 INFO - [mozharness: 2016-07-27 09:57:00.152471Z] Running download-and-extract step. 02:57:00 INFO - Running pre-action listener: _resource_record_pre_action 02:57:00 INFO - Running main action method: download_and_extract 02:57:00 INFO - mkdir: /builds/slave/test/build/tests 02:57:00 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')]} 02:57:00 INFO - https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:57:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:57:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:57:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:57:00 INFO - Downloaded 1361 bytes. 02:57:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:57:00 INFO - Using the following test package requirements: 02:57:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:57:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:57:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:57:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:00 INFO - u'jsshell-linux-x86_64.zip'], 02:57:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:57:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:57:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:57:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:57:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:57:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:57:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:57:00 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')]} 02:57:00 INFO - https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:57:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:57:02 INFO - Downloaded 22744820 bytes. 02:57:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:57:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:57:03 INFO - Return code: 0 02:57:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:03 INFO - https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:57:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:57:08 INFO - Downloaded 22744820 bytes. 02:57:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:57:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:57:09 INFO - Return code: 0 02:57: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')]} 02:57:09 INFO - https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:57:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:57:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:57:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:57:11 INFO - Downloaded 14413725 bytes. 02:57:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:57:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:57:11 INFO - Return code: 0 02:57:11 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')]} 02:57:11 INFO - https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:57:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:57:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:57:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:57:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:57:12 INFO - Downloaded 57169898 bytes. 02:57:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:57:12 INFO - mkdir: /builds/slave/test/properties 02:57:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:12 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:12 INFO - Contents: 02:57:12 INFO - build_url:https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:57:13 INFO - Running post-action listener: _resource_record_post_action 02:57:13 INFO - Running post-action listener: set_extra_try_arguments 02:57:13 INFO - [mozharness: 2016-07-27 09:57:13.386892Z] Finished download-and-extract step (success) 02:57:13 INFO - [mozharness: 2016-07-27 09:57:13.387212Z] Running populate-webroot step. 02:57:13 INFO - Running pre-action listener: _resource_record_pre_action 02:57:13 INFO - Running main action method: populate_webroot 02:57:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:57:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:57:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:57:13 INFO - '--tppagecycles', 02:57:13 INFO - '7'], 02:57:13 INFO - 'tests': ['tsvgm']}}, 02:57:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:57:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:57:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:13 INFO - 'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:13 INFO - 'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['damp', 'tps']}, 02:57:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:13 INFO - 'tests': ['damp', 'tps']}, 02:57:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['dromaeo_dom']}, 02:57:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['basic_compositor_video']}, 02:57:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:57:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['a11yr', 02:57:13 INFO - 'ts_paint', 02:57:13 INFO - 'tpaint', 02:57:13 INFO - 'sessionrestore', 02:57:13 INFO - 'sessionrestore_no_auto_restore', 02:57:13 INFO - 'tabpaint']}, 02:57:13 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:13 INFO - 'ts_paint', 02:57:13 INFO - 'tpaint', 02:57:13 INFO - 'sessionrestore', 02:57:13 INFO - 'sessionrestore_no_auto_restore', 02:57:13 INFO - 'tabpaint']}, 02:57:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:57:13 INFO - 'ts_paint', 02:57:13 INFO - 'tpaint', 02:57:13 INFO - 'sessionrestore', 02:57:13 INFO - 'sessionrestore_no_auto_restore', 02:57:13 INFO - 'tabpaint']}, 02:57:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:57:13 INFO - 'ts_paint', 02:57:13 INFO - 'tpaint', 02:57:13 INFO - 'sessionrestore', 02:57:13 INFO - 'sessionrestore_no_auto_restore', 02:57:13 INFO - 'tabpaint']}, 02:57:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['a11yr', 02:57:13 INFO - 'ts_paint', 02:57:13 INFO - 'tpaint', 02:57:13 INFO - 'sessionrestore', 02:57:13 INFO - 'sessionrestore_no_auto_restore', 02:57:13 INFO - 'tabpaint']}, 02:57:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['a11yr', 02:57:13 INFO - 'ts_paint', 02:57:13 INFO - 'tpaint', 02:57:13 INFO - 'sessionrestore', 02:57:13 INFO - 'sessionrestore_no_auto_restore', 02:57:13 INFO - 'tabpaint']}, 02:57:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['tsvgx', 02:57:13 INFO - 'tsvgr_opacity', 02:57:13 INFO - 'tart', 02:57:13 INFO - 'tscrollx', 02:57:13 INFO - 'cart']}, 02:57:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:13 INFO - 'tsvgr_opacity', 02:57:13 INFO - 'tart', 02:57:13 INFO - 'tscrollx', 02:57:13 INFO - 'cart']}, 02:57:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:13 INFO - 'talos_options': ['--disable-e10s'], 02:57:13 INFO - 'tests': ['tp5o']}, 02:57:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:13 INFO - 'tests': ['tp5o']}, 02:57:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:13 INFO - 'talos_options': ['--disable-e10s', 02:57:13 INFO - '--xperf_path', 02:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:13 INFO - 'tests': ['tp5n']}, 02:57:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:13 INFO - 'talos_options': ['--xperf_path', 02:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:13 INFO - 'tests': ['tp5n']}}, 02:57:13 INFO - 'talos.zip': {'path': '', 02:57:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:57:13 INFO - Running post-action listener: _resource_record_post_action 02:57:13 INFO - [mozharness: 2016-07-27 09:57:13.407949Z] Finished populate-webroot step (success) 02:57:13 INFO - [mozharness: 2016-07-27 09:57:13.408038Z] Running create-virtualenv step. 02:57:13 INFO - Running pre-action listener: _resource_record_pre_action 02:57:13 INFO - Running main action method: create_virtualenv 02:57:13 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:13 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 02:57:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:57:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:13 INFO - Using real prefix '/usr' 02:57:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:14 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:16 INFO - Installing pip.................done. 02:57:16 INFO - Return code: 0 02:57:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:16 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 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:16 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 02:57:16 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 02:57:16 INFO - Using env: {'DISPLAY': ':0', 02:57:16 INFO - 'HOME': '/home/cltbld', 02:57:16 INFO - 'LANG': 'en_US.UTF-8', 02:57:16 INFO - 'LANGUAGE': 'en_US:en', 02:57:16 INFO - 'LOGNAME': 'cltbld', 02:57:16 INFO - 'MAIL': '/var/mail/cltbld', 02:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:16 INFO - 'MOZ_NO_REMOTE': '1', 02:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:16 INFO - 'NO_EM_RESTART': '1', 02:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:16 INFO - 'PWD': '/builds/slave/test', 02:57:16 INFO - 'SHELL': '/bin/bash', 02:57:16 INFO - 'SHLVL': '1', 02:57:16 INFO - 'TERM': 'linux', 02:57:16 INFO - 'TMOUT': '86400', 02:57:16 INFO - 'USER': 'cltbld', 02:57:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:16 INFO - '_': '/tools/buildbot/bin/python'} 02:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:16 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 02:57:16 INFO - Cleaning up... 02:57:16 INFO - Return code: 0 02:57:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:16 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:16 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>=3.1.1'] in /builds/slave/test/build 02:57:16 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>=3.1.1 02:57:16 INFO - Using env: {'DISPLAY': ':0', 02:57:16 INFO - 'HOME': '/home/cltbld', 02:57:16 INFO - 'LANG': 'en_US.UTF-8', 02:57:16 INFO - 'LANGUAGE': 'en_US:en', 02:57:16 INFO - 'LOGNAME': 'cltbld', 02:57:16 INFO - 'MAIL': '/var/mail/cltbld', 02:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:16 INFO - 'MOZ_NO_REMOTE': '1', 02:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:16 INFO - 'NO_EM_RESTART': '1', 02:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:16 INFO - 'PWD': '/builds/slave/test', 02:57:16 INFO - 'SHELL': '/bin/bash', 02:57:16 INFO - 'SHLVL': '1', 02:57:16 INFO - 'TERM': 'linux', 02:57:16 INFO - 'TMOUT': '86400', 02:57:16 INFO - 'USER': 'cltbld', 02:57:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:16 INFO - '_': '/tools/buildbot/bin/python'} 02:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:16 INFO - Downloading/unpacking psutil>=3.1.1 02:57:16 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 02:57:16 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 02:57:16 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 02:57:16 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 02:57:16 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 02:57:16 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 02:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:18 INFO - Installing collected packages: psutil 02:57:18 INFO - Running setup.py install for psutil 02:57:18 INFO - building 'psutil._psutil_linux' extension 02:57:18 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 02:57:18 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 02:57:18 INFO - building 'psutil._psutil_posix' extension 02:57:18 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 02:57:18 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 02:57:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:18 INFO - Successfully installed psutil 02:57:18 INFO - Cleaning up... 02:57:19 INFO - Return code: 0 02:57:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:57:19 INFO - Using env: {'DISPLAY': ':0', 02:57:19 INFO - 'HOME': '/home/cltbld', 02:57:19 INFO - 'LANG': 'en_US.UTF-8', 02:57:19 INFO - 'LANGUAGE': 'en_US:en', 02:57:19 INFO - 'LOGNAME': 'cltbld', 02:57:19 INFO - 'MAIL': '/var/mail/cltbld', 02:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:19 INFO - 'MOZ_NO_REMOTE': '1', 02:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:19 INFO - 'NO_EM_RESTART': '1', 02:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:19 INFO - 'PWD': '/builds/slave/test', 02:57:19 INFO - 'SHELL': '/bin/bash', 02:57:19 INFO - 'SHLVL': '1', 02:57:19 INFO - 'TERM': 'linux', 02:57:19 INFO - 'TMOUT': '86400', 02:57:19 INFO - 'USER': 'cltbld', 02:57:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:19 INFO - '_': '/tools/buildbot/bin/python'} 02:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:57:21 INFO - Installing collected packages: mozsystemmonitor 02:57:21 INFO - Running setup.py install for mozsystemmonitor 02:57:21 INFO - Successfully installed mozsystemmonitor 02:57:21 INFO - Cleaning up... 02:57:21 INFO - Return code: 0 02:57:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:57:21 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')]} 02:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:21 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')]} 02:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:21 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:21 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==2.5.1'] in /builds/slave/test/build 02:57:21 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==2.5.1 02:57:21 INFO - Using env: {'DISPLAY': ':0', 02:57:21 INFO - 'HOME': '/home/cltbld', 02:57:21 INFO - 'LANG': 'en_US.UTF-8', 02:57:21 INFO - 'LANGUAGE': 'en_US:en', 02:57:21 INFO - 'LOGNAME': 'cltbld', 02:57:21 INFO - 'MAIL': '/var/mail/cltbld', 02:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:21 INFO - 'MOZ_NO_REMOTE': '1', 02:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:21 INFO - 'NO_EM_RESTART': '1', 02:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:21 INFO - 'PWD': '/builds/slave/test', 02:57:21 INFO - 'SHELL': '/bin/bash', 02:57:21 INFO - 'SHLVL': '1', 02:57:21 INFO - 'TERM': 'linux', 02:57:21 INFO - 'TMOUT': '86400', 02:57:21 INFO - 'USER': 'cltbld', 02:57:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:21 INFO - '_': '/tools/buildbot/bin/python'} 02:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:21 INFO - Downloading/unpacking jsonschema==2.5.1 02:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:57:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:57: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 02:57: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 02:57: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 02:57: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 02:57: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 02:57: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 02:57:23 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:23 INFO - warning: no files found matching '*.txt' 02:57:23 INFO - no previously-included directories found matching 'build' 02:57:23 INFO - no previously-included directories found matching 'dist' 02:57:23 INFO - no previously-included directories found matching '.git*' 02:57:23 INFO - Installing collected packages: jsonschema, functools32 02:57:23 INFO - Running setup.py install for functools32 02:57:23 INFO - warning: no files found matching '*.txt' 02:57:23 INFO - no previously-included directories found matching 'build' 02:57:23 INFO - no previously-included directories found matching 'dist' 02:57:23 INFO - no previously-included directories found matching '.git*' 02:57:23 INFO - Successfully installed jsonschema functools32 02:57:23 INFO - Cleaning up... 02:57:24 INFO - Return code: 0 02:57:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:57:24 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')]} 02:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:24 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')]} 02:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:24 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:24 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:57:24 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 functools32==3.2.3-2 02:57:24 INFO - Using env: {'DISPLAY': ':0', 02:57:24 INFO - 'HOME': '/home/cltbld', 02:57:24 INFO - 'LANG': 'en_US.UTF-8', 02:57:24 INFO - 'LANGUAGE': 'en_US:en', 02:57:24 INFO - 'LOGNAME': 'cltbld', 02:57:24 INFO - 'MAIL': '/var/mail/cltbld', 02:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:24 INFO - 'MOZ_NO_REMOTE': '1', 02:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:24 INFO - 'NO_EM_RESTART': '1', 02:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:24 INFO - 'PWD': '/builds/slave/test', 02:57:24 INFO - 'SHELL': '/bin/bash', 02:57:24 INFO - 'SHLVL': '1', 02:57:24 INFO - 'TERM': 'linux', 02:57:24 INFO - 'TMOUT': '86400', 02:57:24 INFO - 'USER': 'cltbld', 02:57:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:24 INFO - '_': '/tools/buildbot/bin/python'} 02:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:57:24 INFO - Cleaning up... 02:57:24 INFO - Return code: 0 02:57:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:57:24 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')]} 02:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:24 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')]} 02:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:24 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 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:24 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 02:57:24 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 02:57:24 INFO - Using env: {'DISPLAY': ':0', 02:57:24 INFO - 'HOME': '/home/cltbld', 02:57:24 INFO - 'LANG': 'en_US.UTF-8', 02:57:24 INFO - 'LANGUAGE': 'en_US:en', 02:57:24 INFO - 'LOGNAME': 'cltbld', 02:57:24 INFO - 'MAIL': '/var/mail/cltbld', 02:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:24 INFO - 'MOZ_NO_REMOTE': '1', 02:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:24 INFO - 'NO_EM_RESTART': '1', 02:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:24 INFO - 'PWD': '/builds/slave/test', 02:57:24 INFO - 'SHELL': '/bin/bash', 02:57:24 INFO - 'SHLVL': '1', 02:57:24 INFO - 'TERM': 'linux', 02:57:24 INFO - 'TMOUT': '86400', 02:57:24 INFO - 'USER': 'cltbld', 02:57:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:24 INFO - '_': '/tools/buildbot/bin/python'} 02:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:24 INFO - Downloading/unpacking blobuploader==1.2.4 02:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:26 INFO - Downloading blobuploader-1.2.4.tar.gz 02:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:57:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:57:26 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 02:57:26 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 02:57:26 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 02:57:26 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 02:57:26 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 02:57:26 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 02:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:57:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:57:26 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 02:57:26 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 02:57:26 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 02:57:26 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 02:57:26 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 02:57:26 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 02:57:27 INFO - Downloading docopt-0.6.1.tar.gz 02:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:57:27 INFO - Installing collected packages: blobuploader, requests, docopt 02:57:27 INFO - Running setup.py install for blobuploader 02:57:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:57:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:57:27 INFO - Running setup.py install for requests 02:57:27 INFO - Running setup.py install for docopt 02:57:27 INFO - Successfully installed blobuploader requests docopt 02:57:27 INFO - Cleaning up... 02:57:27 INFO - Return code: 0 02:57:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:27 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 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:27 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 02:57:27 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 02:57:27 INFO - Using env: {'DISPLAY': ':0', 02:57:27 INFO - 'HOME': '/home/cltbld', 02:57:27 INFO - 'LANG': 'en_US.UTF-8', 02:57:27 INFO - 'LANGUAGE': 'en_US:en', 02:57:27 INFO - 'LOGNAME': 'cltbld', 02:57:27 INFO - 'MAIL': '/var/mail/cltbld', 02:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:27 INFO - 'MOZ_NO_REMOTE': '1', 02:57:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:27 INFO - 'NO_EM_RESTART': '1', 02:57:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:27 INFO - 'PWD': '/builds/slave/test', 02:57:27 INFO - 'SHELL': '/bin/bash', 02:57:27 INFO - 'SHLVL': '1', 02:57:27 INFO - 'TERM': 'linux', 02:57:27 INFO - 'TMOUT': '86400', 02:57:27 INFO - 'USER': 'cltbld', 02:57:27 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:27 INFO - '_': '/tools/buildbot/bin/python'} 02:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:27 INFO - Running setup.py (path:/tmp/pip-_E96q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:28 INFO - Running setup.py (path:/tmp/pip-tF4O26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:28 INFO - Running setup.py (path:/tmp/pip-IelI5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:28 INFO - Running setup.py (path:/tmp/pip-qvGw5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:28 INFO - Running setup.py (path:/tmp/pip-yx7yyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:28 INFO - Running setup.py (path:/tmp/pip-qSj3QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:28 INFO - Running setup.py (path:/tmp/pip-Tq1B4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:28 INFO - Running setup.py (path:/tmp/pip-ZsfVIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:28 INFO - Running setup.py (path:/tmp/pip-5HSCTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:28 INFO - Running setup.py (path:/tmp/pip-cEggs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:28 INFO - Running setup.py (path:/tmp/pip-HnJdV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:28 INFO - Running setup.py (path:/tmp/pip-G0S7ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:28 INFO - Running setup.py (path:/tmp/pip-OIzKZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:28 INFO - Running setup.py (path:/tmp/pip-PJ9za7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:28 INFO - Running setup.py (path:/tmp/pip-PZI1Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:29 INFO - Running setup.py (path:/tmp/pip-jNOxZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:29 INFO - Running setup.py (path:/tmp/pip-1mBDQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:57:29 INFO - Running setup.py install for manifestparser 02:57:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Running setup.py install for mozcrash 02:57:29 INFO - Running setup.py install for mozdebug 02:57:29 INFO - Running setup.py install for mozdevice 02:57:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Running setup.py install for mozfile 02:57:29 INFO - Running setup.py install for mozhttpd 02:57:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Running setup.py install for mozinfo 02:57:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Running setup.py install for mozInstall 02:57:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Running setup.py install for mozleak 02:57:30 INFO - Running setup.py install for mozlog 02:57:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:57:30 INFO - Running setup.py install for moznetwork 02:57:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:57:30 INFO - Running setup.py install for mozprocess 02:57:30 INFO - Running setup.py install for mozprofile 02:57:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:57:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:57:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:57:30 INFO - Running setup.py install for mozrunner 02:57:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:57:30 INFO - Running setup.py install for mozscreenshot 02:57:30 INFO - Running setup.py install for moztest 02:57:30 INFO - Running setup.py install for mozversion 02:57:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:57:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:57:30 INFO - Cleaning up... 02:57:30 INFO - Return code: 0 02:57:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:30 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')]} 02:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:30 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')]} 02:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:30 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 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:30 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 02:57:30 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 02:57:30 INFO - Using env: {'DISPLAY': ':0', 02:57:30 INFO - 'HOME': '/home/cltbld', 02:57:30 INFO - 'LANG': 'en_US.UTF-8', 02:57:30 INFO - 'LANGUAGE': 'en_US:en', 02:57:30 INFO - 'LOGNAME': 'cltbld', 02:57:30 INFO - 'MAIL': '/var/mail/cltbld', 02:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:30 INFO - 'MOZ_NO_REMOTE': '1', 02:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:30 INFO - 'NO_EM_RESTART': '1', 02:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:30 INFO - 'PWD': '/builds/slave/test', 02:57:30 INFO - 'SHELL': '/bin/bash', 02:57:30 INFO - 'SHLVL': '1', 02:57:30 INFO - 'TERM': 'linux', 02:57:30 INFO - 'TMOUT': '86400', 02:57:30 INFO - 'USER': 'cltbld', 02:57:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:30 INFO - '_': '/tools/buildbot/bin/python'} 02:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:31 INFO - Running setup.py (path:/tmp/pip-oP0RVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:31 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:31 INFO - Running setup.py (path:/tmp/pip-ArCYZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:31 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:31 INFO - Running setup.py (path:/tmp/pip-6gOcLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:31 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:31 INFO - Running setup.py (path:/tmp/pip-Kf0EyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:31 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:31 INFO - Running setup.py (path:/tmp/pip-A8lCzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:31 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:31 INFO - Running setup.py (path:/tmp/pip-kTxwKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:31 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:31 INFO - Running setup.py (path:/tmp/pip-Gzuh0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:31 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:31 INFO - Running setup.py (path:/tmp/pip-GXlPWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:31 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:31 INFO - Running setup.py (path:/tmp/pip-F1dN5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:31 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:31 INFO - Running setup.py (path:/tmp/pip-AEcf6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:31 INFO - Running setup.py (path:/tmp/pip-r_2VgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:32 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)) 02:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:32 INFO - Running setup.py (path:/tmp/pip-fr0yvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:32 INFO - Running setup.py (path:/tmp/pip-XxpPv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:32 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)) 02:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:32 INFO - Running setup.py (path:/tmp/pip-Uhr_Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:32 INFO - Running setup.py (path:/tmp/pip-bMOz8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:32 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)) 02:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:32 INFO - Running setup.py (path:/tmp/pip-I2GrIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:32 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)) 02:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:32 INFO - Running setup.py (path:/tmp/pip-gnXNla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:32 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)) 02:57:32 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)) 02:57:32 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)) 02:57:32 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)) 02:57:32 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)) 02:57:32 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)) 02:57:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57:32 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 02:57:32 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 02:57:32 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 02:57:32 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 02:57:32 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 02:57:32 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 02:57:34 INFO - Downloading blessings-1.6.tar.gz 02:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:57:34 INFO - Installing collected packages: blessings 02:57:34 INFO - Running setup.py install for blessings 02:57:34 INFO - Successfully installed blessings 02:57:34 INFO - Cleaning up... 02:57:34 INFO - Return code: 0 02:57:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:57:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:34 INFO - Reading from file tmpfile_stdout 02:57:34 INFO - Current package versions: 02:57:34 INFO - argparse == 1.2.1 02:57:34 INFO - blessings == 1.6 02:57:34 INFO - blobuploader == 1.2.4 02:57:34 INFO - docopt == 0.6.1 02:57:34 INFO - functools32 == 3.2.3-2 02:57:34 INFO - jsonschema == 2.5.1 02:57:34 INFO - manifestparser == 1.1 02:57:34 INFO - mozInstall == 1.12 02:57:34 INFO - mozcrash == 0.17 02:57:34 INFO - mozdebug == 0.1 02:57:34 INFO - mozdevice == 0.48 02:57:34 INFO - mozfile == 1.2 02:57:34 INFO - mozhttpd == 0.7 02:57:34 INFO - mozinfo == 0.9 02:57:34 INFO - mozleak == 0.1 02:57:34 INFO - mozlog == 3.3 02:57:34 INFO - moznetwork == 0.27 02:57:34 INFO - mozprocess == 0.23 02:57:34 INFO - mozprofile == 0.28 02:57:34 INFO - mozrunner == 6.12 02:57:34 INFO - mozscreenshot == 0.1 02:57:34 INFO - mozsystemmonitor == 0.3 02:57:34 INFO - moztest == 0.7 02:57:34 INFO - mozversion == 1.4 02:57:34 INFO - psutil == 3.1.1 02:57:34 INFO - requests == 1.2.3 02:57:34 INFO - wsgiref == 0.1.2 02:57:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:34 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 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:34 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 02:57:34 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 02:57:34 INFO - Using env: {'DISPLAY': ':0', 02:57:34 INFO - 'HOME': '/home/cltbld', 02:57:34 INFO - 'LANG': 'en_US.UTF-8', 02:57:34 INFO - 'LANGUAGE': 'en_US:en', 02:57:34 INFO - 'LOGNAME': 'cltbld', 02:57:34 INFO - 'MAIL': '/var/mail/cltbld', 02:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:34 INFO - 'MOZ_NO_REMOTE': '1', 02:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:34 INFO - 'NO_EM_RESTART': '1', 02:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:34 INFO - 'PWD': '/builds/slave/test', 02:57:34 INFO - 'SHELL': '/bin/bash', 02:57:34 INFO - 'SHLVL': '1', 02:57:34 INFO - 'TERM': 'linux', 02:57:34 INFO - 'TMOUT': '86400', 02:57:34 INFO - 'USER': 'cltbld', 02:57:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:34 INFO - '_': '/tools/buildbot/bin/python'} 02:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:35 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)) 02:57:35 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)) 02:57:35 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)) 02:57:35 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)) 02:57:35 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)) 02:57:35 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)) 02:57:35 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)) 02:57:35 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)) 02:57:35 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)) 02:57:35 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)) 02:57:35 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)) 02:57:35 INFO - Cleaning up... 02:57:35 INFO - Return code: 0 02:57:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:35 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 0xae6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, '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': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', '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 02:57:35 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 02:57:35 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 02:57:35 INFO - Using env: {'DISPLAY': ':0', 02:57:35 INFO - 'HOME': '/home/cltbld', 02:57:35 INFO - 'LANG': 'en_US.UTF-8', 02:57:35 INFO - 'LANGUAGE': 'en_US:en', 02:57:35 INFO - 'LOGNAME': 'cltbld', 02:57:35 INFO - 'MAIL': '/var/mail/cltbld', 02:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:35 INFO - 'MOZ_NO_REMOTE': '1', 02:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:35 INFO - 'NO_EM_RESTART': '1', 02:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:35 INFO - 'PWD': '/builds/slave/test', 02:57:35 INFO - 'SHELL': '/bin/bash', 02:57:35 INFO - 'SHLVL': '1', 02:57:35 INFO - 'TERM': 'linux', 02:57:35 INFO - 'TMOUT': '86400', 02:57:35 INFO - 'USER': 'cltbld', 02:57:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:35 INFO - '_': '/tools/buildbot/bin/python'} 02:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:57:35 INFO - Cleaning up... 02:57:35 INFO - Return code: 0 02:57:35 INFO - Running post-action listener: _resource_record_post_action 02:57:35 INFO - Running post-action listener: _start_resource_monitoring 02:57:35 INFO - Starting resource monitoring. 02:57:35 INFO - [mozharness: 2016-07-27 09:57:35.324638Z] Finished create-virtualenv step (success) 02:57:35 INFO - [mozharness: 2016-07-27 09:57:35.325118Z] Running install step. 02:57:35 INFO - Running pre-action listener: _resource_record_pre_action 02:57:35 INFO - Running main action method: install 02:57:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:35 INFO - Reading from file tmpfile_stdout 02:57:35 INFO - Detecting whether we're running mozinstall >=1.0... 02:57:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:57:35 INFO - Reading from file tmpfile_stdout 02:57:35 INFO - Output received: 02:57:35 INFO - Usage: mozinstall [options] installer 02:57:35 INFO - Options: 02:57:35 INFO - -h, --help show this help message and exit 02:57:35 INFO - -d DEST, --destination=DEST 02:57:35 INFO - Directory to install application into. [default: 02:57:35 INFO - "/builds/slave/test"] 02:57:35 INFO - --app=APP Application being installed. [default: firefox] 02:57:35 INFO - mkdir: /builds/slave/test/build/application 02:57:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:57:52 INFO - Reading from file tmpfile_stdout 02:57:52 INFO - Output received: 02:57:52 INFO - /builds/slave/test/build/application/firefox/firefox 02:57:52 INFO - Running post-action listener: _resource_record_post_action 02:57:52 INFO - [mozharness: 2016-07-27 09:57:52.026365Z] Finished install step (success) 02:57:52 INFO - [mozharness: 2016-07-27 09:57:52.026641Z] Running run-tests step. 02:57:52 INFO - Running pre-action listener: _resource_record_pre_action 02:57:52 INFO - Running main action method: run_tests 02:57:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:57:52 INFO - Python 2.7.3 02:57:52 INFO - Return code: 0 02:57:52 INFO - grabbing minidump binary from tooltool 02:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda53b0>, '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 0xda62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:57:52 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 02:57:52 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 02:57:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:57:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:57:52 INFO - Return code: 0 02:57:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:57:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:57:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:57:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:57:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:57:52 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/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 02:57:52 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/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 02:57:52 INFO - Using env: {'DISPLAY': ':0', 02:57:52 INFO - 'HOME': '/home/cltbld', 02:57:52 INFO - 'LANG': 'en_US.UTF-8', 02:57:52 INFO - 'LANGUAGE': 'en_US:en', 02:57:52 INFO - 'LOGNAME': 'cltbld', 02:57:52 INFO - 'MAIL': '/var/mail/cltbld', 02:57:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:57:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:52 INFO - 'MOZ_NO_REMOTE': '1', 02:57:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:52 INFO - 'NO_EM_RESTART': '1', 02:57:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:52 INFO - 'PWD': '/builds/slave/test', 02:57:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:57:52 INFO - 'SHELL': '/bin/bash', 02:57:52 INFO - 'SHLVL': '1', 02:57:52 INFO - 'TERM': 'linux', 02:57:52 INFO - 'TMOUT': '86400', 02:57:52 INFO - 'USER': 'cltbld', 02:57:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089', 02:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:52 INFO - '_': '/tools/buildbot/bin/python'} 02:57:52 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/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 02:57:52 INFO - mozversion application_buildid: 20160727024013 02:57:52 INFO - mozversion application_changeset: 80afb86a5a171430c5d687f7fd697d809505fda3 02:57:52 INFO - mozversion application_display_name: Nightly 02:57:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:57:52 INFO - mozversion application_name: Firefox 02:57:52 INFO - mozversion application_remotingname: firefox 02:57:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:57:52 INFO - mozversion application_vendor: Mozilla 02:57:52 INFO - mozversion application_version: 50.0a1 02:57:52 INFO - mozversion platform_buildid: 20160727024013 02:57:52 INFO - mozversion platform_changeset: 80afb86a5a171430c5d687f7fd697d809505fda3 02:57:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:57:52 INFO - mozversion platform_version: 50.0a1 02:57:52 INFO - using testdate: 1469613472 02:57:52 INFO - actual date: 1469613472 02:57:52 INFO - starting webserver on 'localhost:59473' 02:57:52 INFO - SUITE-START | Running 2 tests 02:57:52 INFO - TEST-START | dromaeo_css 02:57:52 INFO - operating with platform_type : linux_ 02:57:52 INFO - Initialising browser for dromaeo_css test... 02:57:52 INFO - TEST-INFO | started process 3508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVAhkpm/profile http://localhost:59473/getInfo.html) 02:57:55 INFO - PROCESS | 3508 | JavaScript error: , line 0: uncaught exception: undefined 02:57:56 INFO - PROCESS | 3508 | __metrics Screen width/height:1600/1200 02:57:56 INFO - PROCESS | 3508 | colorDepth:24 02:57:56 INFO - PROCESS | 3508 | Browser inner width/height: 1024/697 02:57:56 INFO - PROCESS | 3508 | __metrics 02:57:57 INFO - PROCESS | 3508 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:57:57 INFO - PROCESS | 3508 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:57:58 INFO - PROCESS | 3508 | console.error: PushService: 02:57:58 INFO - PROCESS | 3508 | stateChangeProcessEnqueue: Error transitioning state 02:57:58 INFO - PROCESS | 3508 | UnknownError 02:57:58 INFO - TEST-INFO | 3508: exit 0 02:57:58 INFO - Browser initialized. 02:57:58 INFO - Running cycle 1/1 for dromaeo_css test... 02:57:58 INFO - TEST-INFO | started process 3588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVAhkpm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:10 INFO - PROCESS | 3588 | RSS: Main: 159072256 02:58:10 INFO - PROCESS | 3588 | 02:59:01 INFO - PROCESS | 3588 | 1469613541160 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] 03:01:14 INFO - PROCESS | 3588 | Cycle 1(1): loaded http://localhost:59473/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59473/tests/dromaeo/cssquery-ext.html) 03:01:15 INFO - PROCESS | 3588 | RSS: Main: 275836928 03:01:15 INFO - PROCESS | 3588 | 03:04:18 INFO - PROCESS | 3588 | Cycle 1(1): loaded http://localhost:59473/tests/dromaeo/cssquery-ext.html (next: http://localhost:59473/tests/dromaeo/cssquery-jquery.html) 03:04:18 INFO - PROCESS | 3588 | RSS: Main: 232529920 03:04:18 INFO - PROCESS | 3588 | 03:07:21 INFO - PROCESS | 3588 | Cycle 1(1): loaded http://localhost:59473/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59473/tests/dromaeo/cssquery-mootools.html) 03:07:21 INFO - PROCESS | 3588 | RSS: Main: 225263616 03:07:21 INFO - PROCESS | 3588 | 03:10:23 INFO - PROCESS | 3588 | Cycle 1(1): loaded http://localhost:59473/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59473/tests/dromaeo/cssquery-prototype.html) 03:10:24 INFO - PROCESS | 3588 | RSS: Main: 200220672 03:10:24 INFO - PROCESS | 3588 | 03:13:27 INFO - PROCESS | 3588 | Cycle 1(1): loaded http://localhost:59473/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59473/tests/dromaeo/cssquery-yui.html) 03:13:28 INFO - PROCESS | 3588 | RSS: Main: 188399616 03:13:28 INFO - PROCESS | 3588 | 03:16:31 INFO - PROCESS | 3588 | Cycle 1(1): loaded http://localhost:59473/tests/dromaeo/cssquery-yui.html (next: http://localhost:59473/tests/dromaeo/cssquery-dojo.html) 03:16:31 INFO - PROCESS | 3588 | RSS: Main: 277454848 03:16:31 INFO - PROCESS | 3588 | 03:16:31 INFO - PROCESS | 3588 | __start_tp_report 03:16:31 INFO - PROCESS | 3588 | _x_x_mozilla_page_load 03:16:31 INFO - PROCESS | 3588 | _x_x_mozilla_page_load_details 03:16:31 INFO - PROCESS | 3588 | |i|pagename|runs| 03:16:31 INFO - PROCESS | 3588 | |0;dojo.html;2627.1199148285323;2639.9472010559803;2663.5471969765144;2675.95986060209;2683.7450442207983;4521.525239849818;4596.678232523725;4666.300054991749;4705.999999999995;4739.4075740532435;4595.448546174455;4639.350490931264;4654.0924519718665;4662.930056049162;4697.248440249561;4258.680598955075;4330.566943305668;4342.869713908588;4353.804078816445;4355.433793606827;4316.48202215733;4374.737515749065;4401.823927042915;4440.911181776362;4448.177087238855;4389.692721509496;4413.646908247349;4443.178012067761;4454.109178164364;4461.620762235198;4188.141431006637;4244.0663054128045;4283.850065247701;4291.549387314319;4307.569243075699;4199.475065616798;4201.831926722927;4234.55537168599;4290.849820256276;4374.103308821684;4642.071585682843;4652.860414187579;4668.439787225555;4691.62467002639;4696.365990591295;4909.754512274372;4922.852314430573;4978.377702787152;5029.5221953914315;5032.949670503284;4965.801367945278;4995;5033.647644664875;5042.193249080166;5044.192929131322;4675.088357770236;4684.81260749573;4725.196716558194;4726.95273047272;4730.716157030589;4932.136876046678;5092.159793634083;5160.741962901915;5164.04465173944;5184;5017.874553136127;5021.096202683552;5022.271770593244;5037.29477873098;5038.6976781392505;5042.571381432619;5067.746612669352;5079.6698214615935;5093.592512598983;5096.261042148868;4834.468208497063;4889.608831293488;5007.349044624176;5014.04733100717;5066.518680725325;4885.218365061644;4957.504249575014;4961.206207006934;5004.924926126111;5025.572826309732;4210.936835947463;4212.578742125825;4219.472565929259;4251.957480425218;4253.3619957006695;3707.8516859325323;3721.404575267944;3730.4590834329415;3752.418375151856;3792.563855156692;4189.853355132616;4369.978150109229;4383.846565370197;4388.122375524844;4408.889777755518;5009.624278179152;5011.847275126741;5012.824551140692;5015.971725796203;5043.293938848564;4420.668449866273;4423.159599676115;4428.68999170055;4432.468103827497;4457.710248833815;4334.609885110292;4393.143337049309;4439.600435960779;4457.509673935864;4491.752953587584;4679.672422930362;4694.2723877799;4701.882452938704;4732.455767586772;4742.810287588458;4931.457539670705;4953.331300274417;4955.0089982004465;4957.231629097496;4976.726280054631;4573.588377046081;4673.392458980311;4683.320918466871;4721.645876559341;4800.879978000578;4994.80020799164;5004.324416203912;5008.524190201925;5020.046191223656;5047.2429135629945;5044.571211447068;5049.26785616091;5049.7727602257255;5052.8989420210655;5098.46466121052;4763.54746299101;4819.855404337875;4868.245421959602;4934.8766280843265;4988.152014157529;4887.120318342732;4891.437484689164;4896.779644915916;4917;4923.729194894315;4817.445993710769;4850.781714822912;4858.7570621469495;4859.416869975485;4865.197242455097;4768.427788665383;4835.6131509478455;4862.635302352409;4908.6073114151495;4932.53140951609;4841.4674385816825;4845.176320025534;4860.295257187759;4896.143174944442;4906.435759887659 03:16:31 INFO - PROCESS | 3588 | |1;ext.html;538.487516249462;584.5761822678556;588.03268623115;589.8407429993902;596.9283685957685;26659.733402665966;38629.87535685536;39535.80232098839;39672.603273967325;39798.80100599493;39988.40017399741;40407.39388909169;40430;40485.19029619406;40488.19023619526;7692.807679808007;7825.686972521093;7836.412269079813;7839.3728501719725;7841.0982736985125;7797.220277972186;7875.724349647763;7890.8816367754525;7892.052953645571;7901.565413902233;7892.56590887501;7922.049354077519;7937.563434011127;7942.364610831149;7947.3642108631175;7831.647575859071;7870.212978702141;7878.763637090897;7884.408669349822;7886.093099293568;7829.5302281862705;7879.409044321699;7891.763247102596;7896.644650990662;7898.526088434654;37869;38409;38447.80776096102;38465.42301865474;38476.422853656935;2820.858957052139;2830.6320178376677;2853.971460285412;2896.2904088498244;2955.8965436209846;28751.71248287511;29581.58602217078;29842.70157298421;29881.701182988327;29959.850200749075;3084.552739852731;3099.9070027899197;3117.7505799535984;3140.262038420969;3261.4618587932964;255952;256079;256604.99999999814;256712;257005;41207.793961030606;41473.58526414757;41502.37746433806;41534.584654153674;41537.79231103886;32445.513317300258;33515.329693406;33615;35410;35439;13492.325383730775;13656.24890631005;13662.795058074136;13663.658408539668;13671.658208544866;10144.644937427154;10193.796124077477;10219.948900255451;10221;10230.539625716861;14703.705925881422;14779;14790.299115601629;14801.259937003322;14872.628184295263;6521.282658907517;6722.932770672329;6759.715654025719;6842.6578671066245;6917.757878474229;760.3119177144692;818.6316157729045;896.7668406214431;926.1710768861966;982.9203943583731;26615.866920665274;27220.59169112465;27512;27595;27904.302392439946;711.9644017799089;917.9954100229589;952.8332541805156;961.5624890674726;977.2914636888341;13608.659783505294;13998.930005349908;14378.568642940729;14466.782998255034;14512.419503219753;392916;395026;395050;396474;397693;47938.280925786145;48373.274400884016;48403.515964840604;48410.757946210746;48443.757781210865;1047.4710271312938;1134.8297755336766;1177.2465622001926;1177.2759752751997;1195.0738177912187;26712;28146.437071258868;28454.715452846034;28939.7106028937;29039.709602903702;41214.79392603018;41590;41672.583274168086;41718;41770.58229417788;303622;304988;306842;307033;307316;21963;22193.88903055539;22200.77799221987;22535.436614084778;22567.435814104778;40725.389119162646;41101;41335.586644133175;41364.586354136074;42302;34782.65217347896;34855.12862178466;34964;35025.29949401048;35564.466533001505;35267;35318;35622.64377356193;35712.464313034805;36070.45894311535;35013.8249308762;35147.472787908715;35229;35565.110872228404;36154;30381.392372152874;32384.35231295408;32399.352012959138;32772.34455310928;32780.508292375154;24547.604996801485;24845.254642360756;24869.626955596043;24879.751202487743;25175.244742657018 03:16:31 INFO - PROCESS | 3588 | |2;jquery.html;345.3886620681396;366.3881318198608;370.5220265857044;379.74367302071096;396.6588733689027;12741.872581274185;14317.570472885816;16568.917155414238;16673.16634168293;16864.662706745858;14982.86176152153;16379.181040947964;16444.506664800076;16457.341706331732;16636;4473.150101480716;4721.976390118045;4754.595859351959;4825.831095911643;4835.758212089399;3575.570931488225;4833.854984350475;4863.635227357945;4868.610511159117;4869.342638743759;4453.821847126111;5991.071383935497;6015.578909476317;6083.813656337016;6086.665233412161;5491.093969495028;5814.680192589406;6068.544859135583;6081.513478921675;6081.513478921675;5391.622586418952;5395.81114660985;5398.973005134989;5399.1091469907415;5401;12437.129400941938;12625.179363341445;18961.620767584707;19737.309194178135;19834.70247946282;1840.1811194018667;1857.1085878778126;1934.8355389791743;2117.629414852395;2210.701555290031;9008.909910900873;9182.86225706615;9301.953650162133;9336.813263734688;9575.09036641518;1608.3003893306332;1613.1127879666137;1620.3437607768872;1635.3703824027716;1652.4464304458022;44997.87505312361;58999.41000589982;60321.39678603202;66903.33096669019;69863.30136698618;9679.903200968041;10050.949745251228;10102.444365559964;10124.443155626364;10228.130608898178;14048.297585120703;14055.929720351332;14079.929600351932;14093.718125637635;14099;6860.142482189726;6955.617441040791;7052.188998265266;7057.541259818096;7058.61177635235;6329.873402531924;6354.3010268870385;6438.000432806782;6499.122618446544;6596.505262105361;4356.912861742748;4367.868963931087;4423.284441069517;4453.599176074169;4527.456705195397;1623.3263195773623;1828.7074068149032;1850.9537261568569;1852.5090850924516;1899.1169106365605;704.3344039882364;812.8699408094676;839.26983524333;840.4411066640615;902.1835239108617;15478.767818482731;16247.756283655755;16298.42955496552;17000.744988825176;17362.47912562625;807.4670717326536;831.099195710451;840.4201101240125;844.0488618203981;853.176684499461;7772.961135194288;9056.411333263317;9576;9630.903690963001;9665.951670241604;361973;370550;370714;371428;374233;75216.24783752202;75625.62187189028;75793;76669;77958.61020694861;880.361737740146;880.5245167609547;896.408370475483;898.4339865884451;906.2523418180028;14511.201883896065;14818.481353152589;15209.847901520843;15451.922740386675;15459.227038647798;35921.64078359183;36505.26989460249;36816.63183368132;37343.81328093342;38181.04547386338;55342.16986745282;56119.43880561142;56148;56414.71792641011;57432.42567574438;5930.970345148246;6024.668643224665;7378.335949764547;7634.6946122154495;7764.990551228304;9660;11136.777264454828;11468.770624587629;11767.88232117668;11942.283462992249;9722.902770972483;9790;10047;10253.538590763583;10441.68674939753;4876.731779752147;6778.830529236809;10196.4391958443;10427.322224055411;10492.160627149657;9086;9817.901820981699;9859.950700246452;10173.949130254301;10614.257002010094;7474.962625186839;7710.344620707303;7811.921880781119;7866.72466463671;7875.684972601261;8637.265832404317;9806.165262318478;9838.65564705232;9855.45794981283;10074.244431667801 03:16:31 INFO - PROCESS | 3588 | |3;mootools.html;1335.6794369351355;1388.2642199634195;1438.273671795743;1620.1170362152625;1666.9833301666988;7459;8020.839583208332;8036.718714844981;8037.799055023627;8053.91946080539;6712.731490740364;7478.626068696571;7789.610519474032;7798.610069496531;7964.482308649934;2189.562087582482;2222.3666255117296;2222.8110610598037;2223.321886824518;2224.822014238865;2200.207925146946;2222.955540889181;2258.141906075689;2258.367657056027;2260.2089268755967;2224.6663000549884;2229.721284839395;2238.6865838782583;2239.675247089171;2249.134083377903;2172.858764180339;2187.84685072045;2193.2981445937307;2195.1877805212093;2197.7033100531544;2177.368563116694;2184.202765990402;2187.529681118567;2188.3325585696357;2188.8796116213603;7913.525188488709;8054.033515978062;8067.596620169027;8071.19288071194;8077.35381169505;4421.823127074913;4531.954680453219;4532.7053741507025;4534.161180181677;4548.2495388260895;2782.3534697055966;2957.467655821951;2957.512010518262;2964.9258768530744;2970.77719171063;858.9312854971587;922.7969846633797;924.9768755781092;928.2481190235931;962.7978124593843;10752.73118172044;10782.921707829233;10792.676219713421;10795.892041079645;10798.78402431947;4006.859759908389;4225.154969006149;4320.481542214891;4326.048269380732;4343.717658352197;8900.8664870027;8932.419392739452;8938.37431379797;8944.105589441004;8952.104789521127;4535.365048893158;4544.341070544752;4546.386237857913;4550.362949187116;4555.202839503074;3581.194231297989;3689.169936764207;4001.2797696414923;4138.668906487474;4151.4395556599475;3616.5660120785674;3680.9815950920074;3787.5454945406727;3796.2217745362136;3802.4486449465226;1173.3781096019125;1215.1676101870248;1216.5377156680404;1217.9269243845397;1222.7798996180773;748.5845355827568;774.2605811450052;791.7783020754198;796.3549524884862;797.9960100199578;5018.84943451697;5092.796288148506;5106.617003724736;5151.871203219875;5341.465853414627;397.5626810508418;401.8774273846505;406.20586752898015;407.62498501378803;408.56079714307236;3507.4212754895666;3565.6612621800887;3600.945985810215;3614.98192509041;3683.889483315505;9585.520723963775;10060.748481288027;10106.747331316776;10107.090361867467;10139.594416223415;9984.15134713543;10014.599416023424;10020.549075291483;10042.447665378475;10068;7228.349448549656;7292.562446253241;7293.416526677853;7298.087739032621;7305.305995930378;5029.321041659329;5045.5459008689395;5067.797288108582;5296.41739408657;5379.73101344939;9074.773130671787;9208.585613647268;9212.723618291462;9244.029376915327;9339.439633622005;9075.773105672411;9139.817203655757;9240.445573265626;9246.768830779285;9373.250139988648;6539.247986481616;6750.3924646782025;6760.492963027694;6766.729330826712;6905.102336696197;7506.662200201114;7562.357199638092;7567.848643027219;7576;7581.3176814087;6583.341665833378;6668.83327916806;6698.296678848846;6725.39471447572;6834.179898412222;6519.282878883224;6592.110065141144;6596.60420374779;6758.560693554903;6815;6328.557001009885;6367.649779261999;6398.48812095022;6408.839779005562;6413.935860641333;4574;4598.632109431171;4602.194615942263;4613.354130421811;4695.107929493385;4512.4133862597655;4727.834525791581;4757.785899634456;4840.854774356775;4851.102546028996 03:16:31 INFO - PROCESS | 3588 | |4;prototype.html;306.1763855229433;307.1997446651474;313.7239229478059;316.4809712072202;316.9302753394255;4700.6004489618335;4823.807047718092;4860;4907.803687852486;4938.876528086796;4677.74272415017;4796.712197268166;4816.253480710496;4831.05794370098;4845.2247640377545;3865.342891708416;3872.8063596820048;3874.651281384675;3881.7282790204695;3908.882733517985;3662.688671462929;3686.447032945053;3891.20230352777;3901.102746368337;3912.56961734209;3860.74905131167;3867.4198870169416;3868.2263547290654;3873.573906870242;3894.922101557967;3858.4791053207737;3865.342891708416;3868.400397938324;3874.3533998050716;3881.8160461059365;3414.7609667323295;3420.675035871588;3423;3440.82795860206;3445.689887910075;4525.9180776842695;4735.614035964302;4744.363194697824;4779.976100119512;4783.736894470802;4282.164977829325;4308.74147551148;4320.287152619814;4323.481182258118;4326.913461730779;5056;5068.974655126701;5093.414257360414;5095.235714642796;5151.974240128776;3423.3837909176336;3601.406986969378;3601.657842504958;3621.9275614487565;3650.3246899323444;5284.987557092459;5321.015612111772;5328.307320048369;5349.839504814861;5362.544183744387;3743.344914639927;3743.73793834429;3754.479435828494;3761.7931013793955;3773.24535092977;3670.6145854684873;3803.1442925341576;3804.904877378088;3809.276237514863;3814.809259537012;4275.952391664062;4292.313229883203;4296.398504209413;4302.859742168328;4336.132773445323;5068.543831055223;5086.677463859423;5100.821471248489;5102;5126.743662816844;1235.431701417358;1263.564070395712;1270.0855384123417;1296.3842174967003;1313.3630189358153;797.7435539026058;824.2746383182761;832.6220105725034;837.4682076881103;852.8081181734184;4028.436018957348;4050.2709512287483;4066.573009833984;4069.4506241656995;4098.897527561775;4557.156925968707;4568.789270843229;4574.862754117382;4638.397008388888;4653.604443622262;3982.681385489154;4039.636432721069;4062.3906414037538;4076.470058892325;4123.9381409278885;2388.4148383646116;2453.147873355641;2477.3682710908965;2485.7017157941164;2501.962470562943;4394.560543945579;4409.757463339547;4414.5259877752;4419.381286619876;4433.623142032899;4655.4878963314;4683.508231635629;4741.57325840676;4750.667453278237;4753.120672675566;4065.8895944602405;4362.323839804835;4378.671599630041;4394.198378664732;4405.691601587922;4537.705049171794;4560.293154561048;4589.196890544074;4594;4594.333821595917;4486.743711760712;4492.73043617371;4537.527047758913;4565;4596.5173656765555;4135.81388837497;4356.738595684269;4359.455068116486;4380.802014529475;4388.210122177911;3362.176266814646;3382.763206575516;3382.9681947005415;3385.3060122675283;3414.6414626463866;4657.720536767804;4663.510331415153;5023.623228257822;5074.238864170404;5173.40505841833;5073.086844368049;5091.327053297049;5095.675124467739;5104.927965127216;5115.286379063055;5076.82231121909;5089.567386772166;5105;5108.770105345194;5113.181890897587;4745.952540474551;5011.148104822116;5032.672876263031;5040.42035165946;5045.7981680732355;5127.692538357828;5131.742033505246;5132.255822905583;5152.458991805956;5152.613553983541;5053.772580233972;5066.240063990431;5070.847874563769;5070.949290507196;5076.466970967996 03:16:31 INFO - PROCESS | 3588 | |5;yui.html;611.345859929875;648.4455790299297;650.0152269311993;655.7508146904175;724.786188074518;11869.465874035668;12670.42983065762;12705;12742.61772146836;12787.680307992305;11551;11558.768824623503;11592.942035289832;11660.941695291533;11665.475053622586;610.8839320529107;737.4837613670426;744;768.9192634773352;769.3229957637271;764;764.6559048428202;766.3486036868645;766.9731559395423;770.5299767142039;806.1776987472774;809.7935026568247;810.2302812328282;810.5906517208801;811.0510702478115;508.40516595583074;766.1189631923277;791.8970533830623;795.5346122518333;804.6539987805241;586.8327526654925;586.8591538030885;587.0226073587472;587.1134586773959;587.2014060877203;12398.628041158689;12411.131220814546;12427.689307767378;12429.37853107341;12441.564545240873;12381;12409.813852792215;12620.936895315464;13091.149075310075;13399;11432.828507572392;11519.539218431337;11692.941535292353;11876.406179690981;12398.876011239863;3932;3980.44273801668;4010.9930921785694;4112.691548133872;4132.566080561528;58566.41433585652;59390.70304648492;59587.404125958616;59859.40140598625;60325.6983715083;9631.277654175965;9779.706608801747;9911.900880991097;9953.153981911619;10229.028242317117;18334;18365.449036528924;18368.448946531626;18368.63262734738;18376.356827510972;6456.741730330734;6548.836279092966;6577.21073471177;6583.670816459158;6588.604683718896;3509.5613048368955;3536.9823150884595;3619.3123306571665;3619.3304238715396;3685.005048636853;2663.4673065387;2723.9727602724115;2742.7394397532203;2751.6010178524;2752.2431331384028;460.83870645274555;467.0658682634731;475.8239451403003;479.09451137350436;480.7884530806434;530.3132443485696;549.8900219956025;556.894190103887;557.2783245696833;563.2171281918137;6683.899741503881;6923.826904327432;6994.825129371705;7000.859982800417;7048.702375472165;454.949067653721;475.08071880910546;494.29809670268304;522.5532169994676;545.585355130096;3310.784798988058;3428.4692133401777;3448.9655103448645;3472.878449254264;3570.6072332043454;90386.54806725924;92634;96147;96179;96279.51860240653;53839;81076.59461702654;81274.59362703149;83527;84187;43781.34327985083;59332.70333648304;62525.68737156376;75146.62426687831;75891.62054189804;6842;6843.931560684528;6864.828379290558;7023;7198.244184360567;45772.7711361441;46180.53819461762;47394.28908566443;47410.288845666655;47439;35738.64261357353;61577;65340;65984;65998;8648.481091134552;8693.34799889998;8735.388522803343;8877.600507977028;8972.37193396456;8688.160969620112;8975.237104846161;9025.729228123168;9066.22937050358;9157.49633770149;8103.8379232413845;8372.204640559137;8561.700340488052;8604.139586041596;8629.525376104375;8643.524606146722;8693.739187824376;8733.912660873564;9050.230730387992;9177.77055573616;8091.554964476775;8227.753167404988;8325.750227493185;8335.95832020836;8388.203120703523;7339.9633001834645;7496.400287977058;7505.4746167767735;7636.885446718415;7711.652975615999;6604.4056034955165;7191.137063552198;7201.675924583302;7378.335949764547;7391.963040184764 03:16:31 INFO - PROCESS | 3588 | __end_tp_report 03:16:31 INFO - PROCESS | 3588 | __start_cc_report 03:16:31 INFO - PROCESS | 3588 | _x_x_mozilla_cycle_collect,1155 03:16:31 INFO - PROCESS | 3588 | __end_cc_report 03:16:31 INFO - PROCESS | 3588 | __startTimestamp1469614591379__endTimestamp 03:16:31 INFO - PROCESS | 3588 | 03:16:31 INFO - PROCESS | 3588 | ------- Summary: start ------- 03:16:31 INFO - PROCESS | 3588 | Number of tests: 6 03:16:31 INFO - PROCESS | 3588 | 03:16:31 INFO - PROCESS | 3588 | [#0] dojo.html Cycles:165 Average:4640.18 Median:4739.41 stddev:478.22 (10.1%) stddev-sans-first:452.86 03:16:31 INFO - PROCESS | 3588 | Values: 2627.1 2639.9 2663.5 2676.0 2683.7 4521.5 4596.7 4666.3 4706.0 4739.4 4595.4 4639.4 4654.1 4662.9 4697.2 4258.7 4330.6 4342.9 4353.8 4355.4 4316.5 4374.7 4401.8 4440.9 4448.2 4389.7 4413.6 4443.2 4454.1 4461.6 4188.1 4244.1 4283.9 4291.5 4307.6 4199.5 4201.8 4234.6 4290.8 4374.1 4642.1 4652.9 4668.4 4691.6 4696.4 4909.8 4922.9 4978.4 5029.5 5032.9 4965.8 4995.0 5033.6 5042.2 5044.2 4675.1 4684.8 4725.2 4727.0 4730.7 4932.1 5092.2 5160.7 5164.0 5184.0 5017.9 5021.1 5022.3 5037.3 5038.7 5042.6 5067.7 5079.7 5093.6 5096.3 4834.5 4889.6 5007.3 5014.0 5066.5 4885.2 4957.5 4961.2 5004.9 5025.6 4210.9 4212.6 4219.5 4252.0 4253.4 3707.9 3721.4 3730.5 3752.4 3792.6 4189.9 4370.0 4383.8 4388.1 4408.9 5009.6 5011.8 5012.8 5016.0 5043.3 4420.7 4423.2 4428.7 4432.5 4457.7 4334.6 4393.1 4439.6 4457.5 4491.8 4679.7 4694.3 4701.9 4732.5 4742.8 4931.5 4953.3 4955.0 4957.2 4976.7 4573.6 4673.4 4683.3 4721.6 4800.9 4994.8 5004.3 5008.5 5020.0 5047.2 5044.6 5049.3 5049.8 5052.9 5098.5 4763.5 4819.9 4868.2 4934.9 4988.2 4887.1 4891.4 4896.8 4917.0 4923.7 4817.4 4850.8 4858.8 4859.4 4865.2 4768.4 4835.6 4862.6 4908.6 4932.5 4841.5 4845.2 4860.3 4896.1 4906.4 03:16:31 INFO - PROCESS | 3588 | 03:16:31 INFO - PROCESS | 3588 | [#1] ext.html Cycles:180 Average:46090.44 Median:35564.79 stddev:85521.01 (240.5%) stddev-sans-first:85692.53 03:16:31 INFO - PROCESS | 3588 | Values: 538.5 584.6 588.0 589.8 596.9 26659.7 38629.9 39535.8 39672.6 39798.8 39988.4 40407.4 40430.0 40485.2 40488.2 7692.8 7825.7 7836.4 7839.4 7841.1 7797.2 7875.7 7890.9 7892.1 7901.6 7892.6 7922.0 7937.6 7942.4 7947.4 7831.6 7870.2 7878.8 7884.4 7886.1 7829.5 7879.4 7891.8 7896.6 7898.5 37869.0 38409.0 38447.8 38465.4 38476.4 2820.9 2830.6 2854.0 2896.3 2955.9 28751.7 29581.6 29842.7 29881.7 29959.9 3084.6 3099.9 3117.8 3140.3 3261.5 255952.0 256079.0 256605.0 256712.0 257005.0 41207.8 41473.6 41502.4 41534.6 41537.8 32445.5 33515.3 33615.0 35410.0 35439.0 13492.3 13656.2 13662.8 13663.7 13671.7 10144.6 10193.8 10219.9 10221.0 10230.5 14703.7 14779.0 14790.3 14801.3 14872.6 6521.3 6722.9 6759.7 6842.7 6917.8 760.3 818.6 896.8 926.2 982.9 26615.9 27220.6 27512.0 27595.0 27904.3 712.0 918.0 952.8 961.6 977.3 13608.7 13998.9 14378.6 14466.8 14512.4 392916.0 395026.0 395050.0 396474.0 397693.0 47938.3 48373.3 48403.5 48410.8 48443.8 1047.5 1134.8 1177.2 1177.3 1195.1 26712.0 28146.4 28454.7 28939.7 29039.7 41214.8 41590.0 41672.6 41718.0 41770.6 303622.0 304988.0 306842.0 307033.0 307316.0 21963.0 22193.9 22200.8 22535.4 22567.4 40725.4 41101.0 41335.6 41364.6 42302.0 34782.7 34855.1 34964.0 35025.3 35564.5 35267.0 35318.0 35622.6 35712.5 36070.5 35013.8 35147.5 35229.0 35565.1 36154.0 30381.4 32384.4 32399.4 32772.3 32780.5 24547.6 24845.3 24869.6 24879.8 25175.2 03:16:31 INFO - PROCESS | 3588 | 03:16:31 INFO - PROCESS | 3588 | [#2] jquery.html Cycles:180 Average:23292.95 Median:4849.70 stddev:61158.64 (1261.1%) stddev-sans-first:61305.94 03:16:31 INFO - PROCESS | 3588 | Values: 345.4 366.4 370.5 379.7 396.7 12741.9 14317.6 16568.9 16673.2 16864.7 14982.9 16379.2 16444.5 16457.3 16636.0 4473.2 4722.0 4754.6 4825.8 4835.8 3575.6 4833.9 4863.6 4868.6 4869.3 4453.8 5991.1 6015.6 6083.8 6086.7 5491.1 5814.7 6068.5 6081.5 6081.5 5391.6 5395.8 5399.0 5399.1 5401.0 12437.1 12625.2 18961.6 19737.3 19834.7 1840.2 1857.1 1934.8 2117.6 2210.7 9008.9 9182.9 9302.0 9336.8 9575.1 1608.3 1613.1 1620.3 1635.4 1652.4 44997.9 58999.4 60321.4 66903.3 69863.3 9679.9 10050.9 10102.4 10124.4 10228.1 14048.3 14055.9 14079.9 14093.7 14099.0 6860.1 6955.6 7052.2 7057.5 7058.6 6329.9 6354.3 6438.0 6499.1 6596.5 4356.9 4367.9 4423.3 4453.6 4527.5 1623.3 1828.7 1851.0 1852.5 1899.1 704.3 812.9 839.3 840.4 902.2 15478.8 16247.8 16298.4 17000.7 17362.5 807.5 831.1 840.4 844.0 853.2 7773.0 9056.4 9576.0 9630.9 9666.0 361973.0 370550.0 370714.0 371428.0 374233.0 75216.2 75625.6 75793.0 76669.0 77958.6 880.4 880.5 896.4 898.4 906.3 14511.2 14818.5 15209.8 15451.9 15459.2 35921.6 36505.3 36816.6 37343.8 38181.0 55342.2 56119.4 56148.0 56414.7 57432.4 5931.0 6024.7 7378.3 7634.7 7765.0 9660.0 11136.8 11468.8 11767.9 11942.3 9722.9 9790.0 10047.0 10253.5 10441.7 4876.7 6778.8 10196.4 10427.3 10492.2 9086.0 9817.9 9860.0 10173.9 10614.3 7475.0 7710.3 7811.9 7866.7 7875.7 8637.3 9806.2 9838.7 9855.5 10074.2 03:16:31 INFO - PROCESS | 3588 | 03:16:31 INFO - PROCESS | 3588 | [#3] mootools.html Cycles:180 Average:5167.19 Median:4600.41 stddev:2953.38 (64.2%) stddev-sans-first:2947.63 03:16:31 INFO - PROCESS | 3588 | Values: 1335.7 1388.3 1438.3 1620.1 1667.0 7459.0 8020.8 8036.7 8037.8 8053.9 6712.7 7478.6 7789.6 7798.6 7964.5 2189.6 2222.4 2222.8 2223.3 2224.8 2200.2 2223.0 2258.1 2258.4 2260.2 2224.7 2229.7 2238.7 2239.7 2249.1 2172.9 2187.8 2193.3 2195.2 2197.7 2177.4 2184.2 2187.5 2188.3 2188.9 7913.5 8054.0 8067.6 8071.2 8077.4 4421.8 4532.0 4532.7 4534.2 4548.2 2782.4 2957.5 2957.5 2964.9 2970.8 858.9 922.8 925.0 928.2 962.8 10752.7 10782.9 10792.7 10795.9 10798.8 4006.9 4225.2 4320.5 4326.0 4343.7 8900.9 8932.4 8938.4 8944.1 8952.1 4535.4 4544.3 4546.4 4550.4 4555.2 3581.2 3689.2 4001.3 4138.7 4151.4 3616.6 3681.0 3787.5 3796.2 3802.4 1173.4 1215.2 1216.5 1217.9 1222.8 748.6 774.3 791.8 796.4 798.0 5018.8 5092.8 5106.6 5151.9 5341.5 397.6 401.9 406.2 407.6 408.6 3507.4 3565.7 3600.9 3615.0 3683.9 9585.5 10060.7 10106.7 10107.1 10139.6 9984.2 10014.6 10020.5 10042.4 10068.0 7228.3 7292.6 7293.4 7298.1 7305.3 5029.3 5045.5 5067.8 5296.4 5379.7 9074.8 9208.6 9212.7 9244.0 9339.4 9075.8 9139.8 9240.4 9246.8 9373.3 6539.2 6750.4 6760.5 6766.7 6905.1 7506.7 7562.4 7567.8 7576.0 7581.3 6583.3 6668.8 6698.3 6725.4 6834.2 6519.3 6592.1 6596.6 6758.6 6815.0 6328.6 6367.6 6398.5 6408.8 6413.9 4574.0 4598.6 4602.2 4613.4 4695.1 4512.4 4727.8 4757.8 4840.9 4851.1 03:16:31 INFO - PROCESS | 3588 | 03:16:31 INFO - PROCESS | 3588 | [#4] prototype.html Cycles:180 Average:4073.05 Median:4407.72 stddev:1172.23 (26.6%) stddev-sans-first:1140.91 03:16:31 INFO - PROCESS | 3588 | Values: 306.2 307.2 313.7 316.5 316.9 4700.6 4823.8 4860.0 4907.8 4938.9 4677.7 4796.7 4816.3 4831.1 4845.2 3865.3 3872.8 3874.7 3881.7 3908.9 3662.7 3686.4 3891.2 3901.1 3912.6 3860.7 3867.4 3868.2 3873.6 3894.9 3858.5 3865.3 3868.4 3874.4 3881.8 3414.8 3420.7 3423.0 3440.8 3445.7 4525.9 4735.6 4744.4 4780.0 4783.7 4282.2 4308.7 4320.3 4323.5 4326.9 5056.0 5069.0 5093.4 5095.2 5152.0 3423.4 3601.4 3601.7 3621.9 3650.3 5285.0 5321.0 5328.3 5349.8 5362.5 3743.3 3743.7 3754.5 3761.8 3773.2 3670.6 3803.1 3804.9 3809.3 3814.8 4276.0 4292.3 4296.4 4302.9 4336.1 5068.5 5086.7 5100.8 5102.0 5126.7 1235.4 1263.6 1270.1 1296.4 1313.4 797.7 824.3 832.6 837.5 852.8 4028.4 4050.3 4066.6 4069.5 4098.9 4557.2 4568.8 4574.9 4638.4 4653.6 3982.7 4039.6 4062.4 4076.5 4123.9 2388.4 2453.1 2477.4 2485.7 2502.0 4394.6 4409.8 4414.5 4419.4 4433.6 4655.5 4683.5 4741.6 4750.7 4753.1 4065.9 4362.3 4378.7 4394.2 4405.7 4537.7 4560.3 4589.2 4594.0 4594.3 4486.7 4492.7 4537.5 4565.0 4596.5 4135.8 4356.7 4359.5 4380.8 4388.2 3362.2 3382.8 3383.0 3385.3 3414.6 4657.7 4663.5 5023.6 5074.2 5173.4 5073.1 5091.3 5095.7 5104.9 5115.3 5076.8 5089.6 5105.0 5108.8 5113.2 4746.0 5011.1 5032.7 5040.4 5045.8 5127.7 5131.7 5132.3 5152.5 5152.6 5053.8 5066.2 5070.8 5070.9 5076.5 03:16:31 INFO - PROCESS | 3588 | 03:16:31 INFO - PROCESS | 3588 | [#5] yui.html Cycles:180 Average:16312.58 Median:3552.59 stddev:24053.75 (677.1%) stddev-sans-first:24092.34 03:16:31 INFO - PROCESS | 3588 | Values: 611.3 648.4 650.0 655.8 724.8 11869.5 12670.4 12705.0 12742.6 12787.7 11551.0 11558.8 11592.9 11660.9 11665.5 610.9 737.5 744.0 768.9 769.3 764.0 764.7 766.3 767.0 770.5 806.2 809.8 810.2 810.6 811.1 508.4 766.1 791.9 795.5 804.7 586.8 586.9 587.0 587.1 587.2 12398.6 12411.1 12427.7 12429.4 12441.6 12381.0 12409.8 12620.9 13091.1 13399.0 11432.8 11519.5 11692.9 11876.4 12398.9 3932.0 3980.4 4011.0 4112.7 4132.6 58566.4 59390.7 59587.4 59859.4 60325.7 9631.3 9779.7 9911.9 9953.2 10229.0 18334.0 18365.4 18368.4 18368.6 18376.4 6456.7 6548.8 6577.2 6583.7 6588.6 3509.6 3537.0 3619.3 3619.3 3685.0 2663.5 2724.0 2742.7 2751.6 2752.2 460.8 467.1 475.8 479.1 480.8 530.3 549.9 556.9 557.3 563.2 6683.9 6923.8 6994.8 7000.9 7048.7 454.9 475.1 494.3 522.6 545.6 3310.8 3428.5 3449.0 3472.9 3570.6 90386.5 92634.0 96147.0 96179.0 96279.5 53839.0 81076.6 81274.6 83527.0 84187.0 43781.3 59332.7 62525.7 75146.6 75891.6 6842.0 6843.9 6864.8 7023.0 7198.2 45772.8 46180.5 47394.3 47410.3 47439.0 35738.6 61577.0 65340.0 65984.0 65998.0 8648.5 8693.3 8735.4 8877.6 8972.4 8688.2 8975.2 9025.7 9066.2 9157.5 8103.8 8372.2 8561.7 8604.1 8629.5 8643.5 8693.7 8733.9 9050.2 9177.8 8091.6 8227.8 8325.8 8336.0 8388.2 7340.0 7496.4 7505.5 7636.9 7711.7 6604.4 7191.1 7201.7 7378.3 7392.0 03:16:31 INFO - PROCESS | 3588 | -------- Summary: end -------- 03:16:31 INFO - PROCESS | 3588 | 03:16:32 INFO - TEST-INFO | 3588: exit 0 03:16:32 INFO - TEST-OK | dromaeo_css | took 1119822ms 03:16:32 INFO - TEST-START | kraken 03:16:32 INFO - operating with platform_type : linux_ 03:16:32 INFO - Initialising browser for kraken test... 03:16:32 INFO - TEST-INFO | started process 3769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdcNzF/profile http://localhost:59473/getInfo.html) 03:16:35 INFO - PROCESS | 3769 | JavaScript error: , line 0: uncaught exception: undefined 03:16:36 INFO - PROCESS | 3769 | __metrics Screen width/height:1600/1200 03:16:36 INFO - PROCESS | 3769 | colorDepth:24 03:16:36 INFO - PROCESS | 3769 | Browser inner width/height: 1024/697 03:16:36 INFO - PROCESS | 3769 | __metrics 03:16:37 INFO - PROCESS | 3769 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:16:37 INFO - PROCESS | 3769 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:16:38 INFO - TEST-INFO | 3769: exit 0 03:16:38 INFO - Browser initialized. 03:16:38 INFO - Running cycle 1/1 for kraken test... 03:16:38 INFO - TEST-INFO | started process 3848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcdcNzF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:50 INFO - PROCESS | 3848 | RSS: Main: 159707136 03:16:50 INFO - PROCESS | 3848 | 03:16:53 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59473/tests/kraken/driver.html?testName=audio-beat-detection) 03:16:53 INFO - PROCESS | 3848 | RSS: Main: 216072192 03:16:53 INFO - PROCESS | 3848 | 03:16:56 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59473/tests/kraken/driver.html?testName=audio-dft) 03:16:57 INFO - PROCESS | 3848 | RSS: Main: 194035712 03:16:57 INFO - PROCESS | 3848 | 03:17:00 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59473/tests/kraken/driver.html?testName=audio-fft) 03:17:01 INFO - PROCESS | 3848 | RSS: Main: 273711104 03:17:01 INFO - PROCESS | 3848 | 03:17:03 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59473/tests/kraken/driver.html?testName=audio-oscillator) 03:17:04 INFO - PROCESS | 3848 | RSS: Main: 182157312 03:17:04 INFO - PROCESS | 3848 | 03:17:06 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59473/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:06 INFO - PROCESS | 3848 | RSS: Main: 186888192 03:17:06 INFO - PROCESS | 3848 | 03:17:10 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59473/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:10 INFO - PROCESS | 3848 | RSS: Main: 223432704 03:17:10 INFO - PROCESS | 3848 | 03:17:14 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59473/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:14 INFO - PROCESS | 3848 | RSS: Main: 217403392 03:17:14 INFO - PROCESS | 3848 | 03:17:17 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59473/tests/kraken/driver.html?testName=json-parse-financial) 03:17:18 INFO - PROCESS | 3848 | RSS: Main: 220225536 03:17:18 INFO - PROCESS | 3848 | 03:17:19 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59473/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:20 INFO - PROCESS | 3848 | RSS: Main: 186167296 03:17:20 INFO - PROCESS | 3848 | 03:17:22 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59473/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:23 INFO - PROCESS | 3848 | RSS: Main: 190898176 03:17:23 INFO - PROCESS | 3848 | 03:17:25 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59473/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:17:25 INFO - PROCESS | 3848 | RSS: Main: 196624384 03:17:25 INFO - PROCESS | 3848 | 03:17:28 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:17:29 INFO - PROCESS | 3848 | RSS: Main: 190742528 03:17:29 INFO - PROCESS | 3848 | 03:17:32 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:17:32 INFO - PROCESS | 3848 | RSS: Main: 193769472 03:17:32 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:59473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59473/tests/kraken/driver.html?testName=ai-astar) 03:17:34 INFO - PROCESS | 3848 | RSS: Main: 245530624 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | __start_tp_report 03:17:34 INFO - PROCESS | 3848 | _x_x_mozilla_page_load 03:17:34 INFO - PROCESS | 3848 | _x_x_mozilla_page_load_details 03:17:34 INFO - PROCESS | 3848 | |i|pagename|runs| 03:17:34 INFO - PROCESS | 3848 | |0;ai-astar;105;114;114;115;113;112;113;115;113;115 03:17:34 INFO - PROCESS | 3848 | |1;audio-beat-detection;162;122;130;175;125;131;148;124;183;127 03:17:34 INFO - PROCESS | 3848 | |2;audio-dft;166;163;162;161;163;162;163;161;164;162 03:17:34 INFO - PROCESS | 3848 | |3;audio-fft;76;76;76;123;78;79;75;77;102;78 03:17:34 INFO - PROCESS | 3848 | |4;audio-oscillator;84;85;112;85;85;84;116;84;85;121 03:17:34 INFO - PROCESS | 3848 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;117 03:17:34 INFO - PROCESS | 3848 | |6;imaging-darkroom;147;146;146;146;146;146;147;146;145;146 03:17:34 INFO - PROCESS | 3848 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 03:17:34 INFO - PROCESS | 3848 | |8;json-parse-financial;63;63;62;61;63;63;63;64;62;61 03:17:34 INFO - PROCESS | 3848 | |9;json-stringify-tinderbox;66;66;66;65;66;66;66;66;66;66 03:17:34 INFO - PROCESS | 3848 | |10;stanford-crypto-aes;79;92;85;78;78;80;80;79;81;84 03:17:34 INFO - PROCESS | 3848 | |11;stanford-crypto-ccm;133;135;138;130;128;130;129;138;170;129 03:17:34 INFO - PROCESS | 3848 | |12;stanford-crypto-pbkdf2;169;170;164;165;164;172;169;163;166;164 03:17:34 INFO - PROCESS | 3848 | |13;stanford-crypto-sha256-iterative;66;68;67;66;68;67;67;66;66;66 03:17:34 INFO - PROCESS | 3848 | __end_tp_report 03:17:34 INFO - PROCESS | 3848 | __start_cc_report 03:17:34 INFO - PROCESS | 3848 | _x_x_mozilla_cycle_collect,1923 03:17:34 INFO - PROCESS | 3848 | __end_cc_report 03:17:34 INFO - PROCESS | 3848 | __startTimestamp1469614654723__endTimestamp 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | ------- Summary: start ------- 03:17:34 INFO - PROCESS | 3848 | Number of tests: 14 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.96 (2.6%) stddev-sans-first:1.09 03:17:34 INFO - PROCESS | 3848 | Values: 105.0 114.0 114.0 115.0 113.0 112.0 113.0 115.0 113.0 115.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:139.50 stddev:22.86 (16.4%) stddev-sans-first:23.16 03:17:34 INFO - PROCESS | 3848 | Values: 162.0 122.0 130.0 175.0 125.0 131.0 148.0 124.0 183.0 127.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.00 03:17:34 INFO - PROCESS | 3848 | Values: 166.0 163.0 162.0 161.0 163.0 162.0 163.0 161.0 164.0 162.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#3] audio-fft Cycles:10 Average:84.00 Median:76.50 stddev:15.86 (20.7%) stddev-sans-first:16.56 03:17:34 INFO - PROCESS | 3848 | Values: 76.0 76.0 76.0 123.0 78.0 79.0 75.0 77.0 102.0 78.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.50 stddev:15.50 (18.3%) stddev-sans-first:16.00 03:17:34 INFO - PROCESS | 3848 | Values: 84.0 85.0 112.0 85.0 85.0 84.0 116.0 84.0 85.0 121.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:17:34 INFO - PROCESS | 3848 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 03:17:34 INFO - PROCESS | 3848 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:17:34 INFO - PROCESS | 3848 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 03:17:34 INFO - PROCESS | 3848 | Values: 63.0 63.0 62.0 61.0 63.0 63.0 63.0 64.0 62.0 61.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 03:17:34 INFO - PROCESS | 3848 | Values: 66.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:4.35 (5.4%) stddev-sans-first:4.51 03:17:34 INFO - PROCESS | 3848 | Values: 79.0 92.0 85.0 78.0 78.0 80.0 80.0 79.0 81.0 84.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:134.00 stddev:12.51 (9.3%) stddev-sans-first:13.22 03:17:34 INFO - PROCESS | 3848 | Values: 133.0 135.0 138.0 130.0 128.0 130.0 129.0 138.0 170.0 129.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:167.50 stddev:3.13 (1.9%) stddev-sans-first:3.20 03:17:34 INFO - PROCESS | 3848 | Values: 169.0 170.0 164.0 165.0 164.0 172.0 169.0 163.0 166.0 164.0 03:17:34 INFO - PROCESS | 3848 | 03:17:34 INFO - PROCESS | 3848 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 03:17:34 INFO - PROCESS | 3848 | Values: 66.0 68.0 67.0 66.0 68.0 67.0 67.0 66.0 66.0 66.0 03:17:34 INFO - PROCESS | 3848 | -------- Summary: end -------- 03:17:34 INFO - PROCESS | 3848 | 03:17:35 INFO - TEST-INFO | 3848: exit 0 03:17:35 INFO - TEST-OK | kraken | took 63769ms 03:17:35 INFO - SUITE-END | took 1183s 03:17:36 INFO - Completed test suite (00:19:44) 03:17:36 INFO - javascript benchmark 03:17:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.1199148285323, 2639.9472010559803, 2663.5471969765144, 2675.95986060209, 2683.7450442207983, 4521.525239849818, 4596.678232523725, 4666.300054991749, 4705.999999999995, 4739.4075740532435, 4595.448546174455, 4639.350490931264, 4654.0924519718665, 4662.930056049162, 4697.248440249561, 4258.680598955075, 4330.566943305668, 4342.869713908588, 4353.804078816445, 4355.433793606827, 4316.48202215733, 4374.737515749065, 4401.823927042915, 4440.911181776362, 4448.177087238855, 4389.692721509496, 4413.646908247349, 4443.178012067761, 4454.109178164364, 4461.620762235198, 4188.141431006637, 4244.0663054128045, 4283.850065247701, 4291.549387314319, 4307.569243075699, 4199.475065616798, 4201.831926722927, 4234.55537168599, 4290.849820256276, 4374.103308821684, 4642.071585682843, 4652.860414187579, 4668.439787225555, 4691.62467002639, 4696.365990591295, 4909.754512274372, 4922.852314430573, 4978.377702787152, 5029.5221953914315, 5032.949670503284, 4965.801367945278, 4995.0, 5033.647644664875, 5042.193249080166, 5044.192929131322, 4675.088357770236, 4684.81260749573, 4725.196716558194, 4726.95273047272, 4730.716157030589, 4932.136876046678, 5092.159793634083, 5160.741962901915, 5164.04465173944, 5184.0, 5017.874553136127, 5021.096202683552, 5022.271770593244, 5037.29477873098, 5038.6976781392505, 5042.571381432619, 5067.746612669352, 5079.6698214615935, 5093.592512598983, 5096.261042148868, 4834.468208497063, 4889.608831293488, 5007.349044624176, 5014.04733100717, 5066.518680725325, 4885.218365061644, 4957.504249575014, 4961.206207006934, 5004.924926126111, 5025.572826309732, 4210.936835947463, 4212.578742125825, 4219.472565929259, 4251.957480425218, 4253.3619957006695, 3707.8516859325323, 3721.404575267944, 3730.4590834329415, 3752.418375151856, 3792.563855156692, 4189.853355132616, 4369.978150109229, 4383.846565370197, 4388.122375524844, 4408.889777755518, 5009.624278179152, 5011.847275126741, 5012.824551140692, 5015.971725796203, 5043.293938848564, 4420.668449866273, 4423.159599676115, 4428.68999170055, 4432.468103827497, 4457.710248833815, 4334.609885110292, 4393.143337049309, 4439.600435960779, 4457.509673935864, 4491.752953587584, 4679.672422930362, 4694.2723877799, 4701.882452938704, 4732.455767586772, 4742.810287588458, 4931.457539670705, 4953.331300274417, 4955.0089982004465, 4957.231629097496, 4976.726280054631, 4573.588377046081, 4673.392458980311, 4683.320918466871, 4721.645876559341, 4800.879978000578, 4994.80020799164, 5004.324416203912, 5008.524190201925, 5020.046191223656, 5047.2429135629945, 5044.571211447068, 5049.26785616091, 5049.7727602257255, 5052.8989420210655, 5098.46466121052, 4763.54746299101, 4819.855404337875, 4868.245421959602, 4934.8766280843265, 4988.152014157529, 4887.120318342732, 4891.437484689164, 4896.779644915916, 4917.0, 4923.729194894315, 4817.445993710769, 4850.781714822912, 4858.7570621469495, 4859.416869975485, 4865.197242455097, 4768.427788665383, 4835.6131509478455, 4862.635302352409, 4908.6073114151495, 4932.53140951609, 4841.4674385816825, 4845.176320025534, 4860.295257187759, 4896.143174944442, 4906.435759887659], "value": 4610.335111056905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.487516249462, 584.5761822678556, 588.03268623115, 589.8407429993902, 596.9283685957685, 26659.733402665966, 38629.87535685536, 39535.80232098839, 39672.603273967325, 39798.80100599493, 39988.40017399741, 40407.39388909169, 40430.0, 40485.19029619406, 40488.19023619526, 7692.807679808007, 7825.686972521093, 7836.412269079813, 7839.3728501719725, 7841.0982736985125, 7797.220277972186, 7875.724349647763, 7890.8816367754525, 7892.052953645571, 7901.565413902233, 7892.56590887501, 7922.049354077519, 7937.563434011127, 7942.364610831149, 7947.3642108631175, 7831.647575859071, 7870.212978702141, 7878.763637090897, 7884.408669349822, 7886.093099293568, 7829.5302281862705, 7879.409044321699, 7891.763247102596, 7896.644650990662, 7898.526088434654, 37869.0, 38409.0, 38447.80776096102, 38465.42301865474, 38476.422853656935, 2820.858957052139, 2830.6320178376677, 2853.971460285412, 2896.2904088498244, 2955.8965436209846, 28751.71248287511, 29581.58602217078, 29842.70157298421, 29881.701182988327, 29959.850200749075, 3084.552739852731, 3099.9070027899197, 3117.7505799535984, 3140.262038420969, 3261.4618587932964, 255952.0, 256079.0, 256604.99999999814, 256712.0, 257005.0, 41207.793961030606, 41473.58526414757, 41502.37746433806, 41534.584654153674, 41537.79231103886, 32445.513317300258, 33515.329693406, 33615.0, 35410.0, 35439.0, 13492.325383730775, 13656.24890631005, 13662.795058074136, 13663.658408539668, 13671.658208544866, 10144.644937427154, 10193.796124077477, 10219.948900255451, 10221.0, 10230.539625716861, 14703.705925881422, 14779.0, 14790.299115601629, 14801.259937003322, 14872.628184295263, 6521.282658907517, 6722.932770672329, 6759.715654025719, 6842.6578671066245, 6917.757878474229, 760.3119177144692, 818.6316157729045, 896.7668406214431, 926.1710768861966, 982.9203943583731, 26615.866920665274, 27220.59169112465, 27512.0, 27595.0, 27904.302392439946, 711.9644017799089, 917.9954100229589, 952.8332541805156, 961.5624890674726, 977.2914636888341, 13608.659783505294, 13998.930005349908, 14378.568642940729, 14466.782998255034, 14512.419503219753, 392916.0, 395026.0, 395050.0, 396474.0, 397693.0, 47938.280925786145, 48373.274400884016, 48403.515964840604, 48410.757946210746, 48443.757781210865, 1047.4710271312938, 1134.8297755336766, 1177.2465622001926, 1177.2759752751997, 1195.0738177912187, 26712.0, 28146.437071258868, 28454.715452846034, 28939.7106028937, 29039.709602903702, 41214.79392603018, 41590.0, 41672.583274168086, 41718.0, 41770.58229417788, 303622.0, 304988.0, 306842.0, 307033.0, 307316.0, 21963.0, 22193.88903055539, 22200.77799221987, 22535.436614084778, 22567.435814104778, 40725.389119162646, 41101.0, 41335.586644133175, 41364.586354136074, 42302.0, 34782.65217347896, 34855.12862178466, 34964.0, 35025.29949401048, 35564.466533001505, 35267.0, 35318.0, 35622.64377356193, 35712.464313034805, 36070.45894311535, 35013.8249308762, 35147.472787908715, 35229.0, 35565.110872228404, 36154.0, 30381.392372152874, 32384.35231295408, 32399.352012959138, 32772.34455310928, 32780.508292375154, 24547.604996801485, 24845.254642360756, 24869.626955596043, 24879.751202487743, 25175.244742657018], "value": 16710.28321530677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.3886620681396, 366.3881318198608, 370.5220265857044, 379.74367302071096, 396.6588733689027, 12741.872581274185, 14317.570472885816, 16568.917155414238, 16673.16634168293, 16864.662706745858, 14982.86176152153, 16379.181040947964, 16444.506664800076, 16457.341706331732, 16636.0, 4473.150101480716, 4721.976390118045, 4754.595859351959, 4825.831095911643, 4835.758212089399, 3575.570931488225, 4833.854984350475, 4863.635227357945, 4868.610511159117, 4869.342638743759, 4453.821847126111, 5991.071383935497, 6015.578909476317, 6083.813656337016, 6086.665233412161, 5491.093969495028, 5814.680192589406, 6068.544859135583, 6081.513478921675, 6081.513478921675, 5391.622586418952, 5395.81114660985, 5398.973005134989, 5399.1091469907415, 5401.0, 12437.129400941938, 12625.179363341445, 18961.620767584707, 19737.309194178135, 19834.70247946282, 1840.1811194018667, 1857.1085878778126, 1934.8355389791743, 2117.629414852395, 2210.701555290031, 9008.909910900873, 9182.86225706615, 9301.953650162133, 9336.813263734688, 9575.09036641518, 1608.3003893306332, 1613.1127879666137, 1620.3437607768872, 1635.3703824027716, 1652.4464304458022, 44997.87505312361, 58999.41000589982, 60321.39678603202, 66903.33096669019, 69863.30136698618, 9679.903200968041, 10050.949745251228, 10102.444365559964, 10124.443155626364, 10228.130608898178, 14048.297585120703, 14055.929720351332, 14079.929600351932, 14093.718125637635, 14099.0, 6860.142482189726, 6955.617441040791, 7052.188998265266, 7057.541259818096, 7058.61177635235, 6329.873402531924, 6354.3010268870385, 6438.000432806782, 6499.122618446544, 6596.505262105361, 4356.912861742748, 4367.868963931087, 4423.284441069517, 4453.599176074169, 4527.456705195397, 1623.3263195773623, 1828.7074068149032, 1850.9537261568569, 1852.5090850924516, 1899.1169106365605, 704.3344039882364, 812.8699408094676, 839.26983524333, 840.4411066640615, 902.1835239108617, 15478.767818482731, 16247.756283655755, 16298.42955496552, 17000.744988825176, 17362.47912562625, 807.4670717326536, 831.099195710451, 840.4201101240125, 844.0488618203981, 853.176684499461, 7772.961135194288, 9056.411333263317, 9576.0, 9630.903690963001, 9665.951670241604, 361973.0, 370550.0, 370714.0, 371428.0, 374233.0, 75216.24783752202, 75625.62187189028, 75793.0, 76669.0, 77958.61020694861, 880.361737740146, 880.5245167609547, 896.408370475483, 898.4339865884451, 906.2523418180028, 14511.201883896065, 14818.481353152589, 15209.847901520843, 15451.922740386675, 15459.227038647798, 35921.64078359183, 36505.26989460249, 36816.63183368132, 37343.81328093342, 38181.04547386338, 55342.16986745282, 56119.43880561142, 56148.0, 56414.71792641011, 57432.42567574438, 5930.970345148246, 6024.668643224665, 7378.335949764547, 7634.6946122154495, 7764.990551228304, 9660.0, 11136.777264454828, 11468.770624587629, 11767.88232117668, 11942.283462992249, 9722.902770972483, 9790.0, 10047.0, 10253.538590763583, 10441.68674939753, 4876.731779752147, 6778.830529236809, 10196.4391958443, 10427.322224055411, 10492.160627149657, 9086.0, 9817.901820981699, 9859.950700246452, 10173.949130254301, 10614.257002010094, 7474.962625186839, 7710.344620707303, 7811.921880781119, 7866.72466463671, 7875.684972601261, 8637.265832404317, 9806.165262318478, 9838.65564705232, 9855.45794981283, 10074.244431667801], "value": 7924.78570666958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.6794369351355, 1388.2642199634195, 1438.273671795743, 1620.1170362152625, 1666.9833301666988, 7459.0, 8020.839583208332, 8036.718714844981, 8037.799055023627, 8053.91946080539, 6712.731490740364, 7478.626068696571, 7789.610519474032, 7798.610069496531, 7964.482308649934, 2189.562087582482, 2222.3666255117296, 2222.8110610598037, 2223.321886824518, 2224.822014238865, 2200.207925146946, 2222.955540889181, 2258.141906075689, 2258.367657056027, 2260.2089268755967, 2224.6663000549884, 2229.721284839395, 2238.6865838782583, 2239.675247089171, 2249.134083377903, 2172.858764180339, 2187.84685072045, 2193.2981445937307, 2195.1877805212093, 2197.7033100531544, 2177.368563116694, 2184.202765990402, 2187.529681118567, 2188.3325585696357, 2188.8796116213603, 7913.525188488709, 8054.033515978062, 8067.596620169027, 8071.19288071194, 8077.35381169505, 4421.823127074913, 4531.954680453219, 4532.7053741507025, 4534.161180181677, 4548.2495388260895, 2782.3534697055966, 2957.467655821951, 2957.512010518262, 2964.9258768530744, 2970.77719171063, 858.9312854971587, 922.7969846633797, 924.9768755781092, 928.2481190235931, 962.7978124593843, 10752.73118172044, 10782.921707829233, 10792.676219713421, 10795.892041079645, 10798.78402431947, 4006.859759908389, 4225.154969006149, 4320.481542214891, 4326.048269380732, 4343.717658352197, 8900.8664870027, 8932.419392739452, 8938.37431379797, 8944.105589441004, 8952.104789521127, 4535.365048893158, 4544.341070544752, 4546.386237857913, 4550.362949187116, 4555.202839503074, 3581.194231297989, 3689.169936764207, 4001.2797696414923, 4138.668906487474, 4151.4395556599475, 3616.5660120785674, 3680.9815950920074, 3787.5454945406727, 3796.2217745362136, 3802.4486449465226, 1173.3781096019125, 1215.1676101870248, 1216.5377156680404, 1217.9269243845397, 1222.7798996180773, 748.5845355827568, 774.2605811450052, 791.7783020754198, 796.3549524884862, 797.9960100199578, 5018.84943451697, 5092.796288148506, 5106.617003724736, 5151.871203219875, 5341.465853414627, 397.5626810508418, 401.8774273846505, 406.20586752898015, 407.62498501378803, 408.56079714307236, 3507.4212754895666, 3565.6612621800887, 3600.945985810215, 3614.98192509041, 3683.889483315505, 9585.520723963775, 10060.748481288027, 10106.747331316776, 10107.090361867467, 10139.594416223415, 9984.15134713543, 10014.599416023424, 10020.549075291483, 10042.447665378475, 10068.0, 7228.349448549656, 7292.562446253241, 7293.416526677853, 7298.087739032621, 7305.305995930378, 5029.321041659329, 5045.5459008689395, 5067.797288108582, 5296.41739408657, 5379.73101344939, 9074.773130671787, 9208.585613647268, 9212.723618291462, 9244.029376915327, 9339.439633622005, 9075.773105672411, 9139.817203655757, 9240.445573265626, 9246.768830779285, 9373.250139988648, 6539.247986481616, 6750.3924646782025, 6760.492963027694, 6766.729330826712, 6905.102336696197, 7506.662200201114, 7562.357199638092, 7567.848643027219, 7576.0, 7581.3176814087, 6583.341665833378, 6668.83327916806, 6698.296678848846, 6725.39471447572, 6834.179898412222, 6519.282878883224, 6592.110065141144, 6596.60420374779, 6758.560693554903, 6815.0, 6328.557001009885, 6367.649779261999, 6398.48812095022, 6408.839779005562, 6413.935860641333, 4574.0, 4598.632109431171, 4602.194615942263, 4613.354130421811, 4695.107929493385, 4512.4133862597655, 4727.834525791581, 4757.785899634456, 4840.854774356775, 4851.102546028996], "value": 4073.085222121508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.1763855229433, 307.1997446651474, 313.7239229478059, 316.4809712072202, 316.9302753394255, 4700.6004489618335, 4823.807047718092, 4860.0, 4907.803687852486, 4938.876528086796, 4677.74272415017, 4796.712197268166, 4816.253480710496, 4831.05794370098, 4845.2247640377545, 3865.342891708416, 3872.8063596820048, 3874.651281384675, 3881.7282790204695, 3908.882733517985, 3662.688671462929, 3686.447032945053, 3891.20230352777, 3901.102746368337, 3912.56961734209, 3860.74905131167, 3867.4198870169416, 3868.2263547290654, 3873.573906870242, 3894.922101557967, 3858.4791053207737, 3865.342891708416, 3868.400397938324, 3874.3533998050716, 3881.8160461059365, 3414.7609667323295, 3420.675035871588, 3423.0, 3440.82795860206, 3445.689887910075, 4525.9180776842695, 4735.614035964302, 4744.363194697824, 4779.976100119512, 4783.736894470802, 4282.164977829325, 4308.74147551148, 4320.287152619814, 4323.481182258118, 4326.913461730779, 5056.0, 5068.974655126701, 5093.414257360414, 5095.235714642796, 5151.974240128776, 3423.3837909176336, 3601.406986969378, 3601.657842504958, 3621.9275614487565, 3650.3246899323444, 5284.987557092459, 5321.015612111772, 5328.307320048369, 5349.839504814861, 5362.544183744387, 3743.344914639927, 3743.73793834429, 3754.479435828494, 3761.7931013793955, 3773.24535092977, 3670.6145854684873, 3803.1442925341576, 3804.904877378088, 3809.276237514863, 3814.809259537012, 4275.952391664062, 4292.313229883203, 4296.398504209413, 4302.859742168328, 4336.132773445323, 5068.543831055223, 5086.677463859423, 5100.821471248489, 5102.0, 5126.743662816844, 1235.431701417358, 1263.564070395712, 1270.0855384123417, 1296.3842174967003, 1313.3630189358153, 797.7435539026058, 824.2746383182761, 832.6220105725034, 837.4682076881103, 852.8081181734184, 4028.436018957348, 4050.2709512287483, 4066.573009833984, 4069.4506241656995, 4098.897527561775, 4557.156925968707, 4568.789270843229, 4574.862754117382, 4638.397008388888, 4653.604443622262, 3982.681385489154, 4039.636432721069, 4062.3906414037538, 4076.470058892325, 4123.9381409278885, 2388.4148383646116, 2453.147873355641, 2477.3682710908965, 2485.7017157941164, 2501.962470562943, 4394.560543945579, 4409.757463339547, 4414.5259877752, 4419.381286619876, 4433.623142032899, 4655.4878963314, 4683.508231635629, 4741.57325840676, 4750.667453278237, 4753.120672675566, 4065.8895944602405, 4362.323839804835, 4378.671599630041, 4394.198378664732, 4405.691601587922, 4537.705049171794, 4560.293154561048, 4589.196890544074, 4594.0, 4594.333821595917, 4486.743711760712, 4492.73043617371, 4537.527047758913, 4565.0, 4596.5173656765555, 4135.81388837497, 4356.738595684269, 4359.455068116486, 4380.802014529475, 4388.210122177911, 3362.176266814646, 3382.763206575516, 3382.9681947005415, 3385.3060122675283, 3414.6414626463866, 4657.720536767804, 4663.510331415153, 5023.623228257822, 5074.238864170404, 5173.40505841833, 5073.086844368049, 5091.327053297049, 5095.675124467739, 5104.927965127216, 5115.286379063055, 5076.82231121909, 5089.567386772166, 5105.0, 5108.770105345194, 5113.181890897587, 4745.952540474551, 5011.148104822116, 5032.672876263031, 5040.42035165946, 5045.7981680732355, 5127.692538357828, 5131.742033505246, 5132.255822905583, 5152.458991805956, 5152.613553983541, 5053.772580233972, 5066.240063990431, 5070.847874563769, 5070.949290507196, 5076.466970967996], "value": 3706.3616110907087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.345859929875, 648.4455790299297, 650.0152269311993, 655.7508146904175, 724.786188074518, 11869.465874035668, 12670.42983065762, 12705.0, 12742.61772146836, 12787.680307992305, 11551.0, 11558.768824623503, 11592.942035289832, 11660.941695291533, 11665.475053622586, 610.8839320529107, 737.4837613670426, 744.0, 768.9192634773352, 769.3229957637271, 764.0, 764.6559048428202, 766.3486036868645, 766.9731559395423, 770.5299767142039, 806.1776987472774, 809.7935026568247, 810.2302812328282, 810.5906517208801, 811.0510702478115, 508.40516595583074, 766.1189631923277, 791.8970533830623, 795.5346122518333, 804.6539987805241, 586.8327526654925, 586.8591538030885, 587.0226073587472, 587.1134586773959, 587.2014060877203, 12398.628041158689, 12411.131220814546, 12427.689307767378, 12429.37853107341, 12441.564545240873, 12381.0, 12409.813852792215, 12620.936895315464, 13091.149075310075, 13399.0, 11432.828507572392, 11519.539218431337, 11692.941535292353, 11876.406179690981, 12398.876011239863, 3932.0, 3980.44273801668, 4010.9930921785694, 4112.691548133872, 4132.566080561528, 58566.41433585652, 59390.70304648492, 59587.404125958616, 59859.40140598625, 60325.6983715083, 9631.277654175965, 9779.706608801747, 9911.900880991097, 9953.153981911619, 10229.028242317117, 18334.0, 18365.449036528924, 18368.448946531626, 18368.63262734738, 18376.356827510972, 6456.741730330734, 6548.836279092966, 6577.21073471177, 6583.670816459158, 6588.604683718896, 3509.5613048368955, 3536.9823150884595, 3619.3123306571665, 3619.3304238715396, 3685.005048636853, 2663.4673065387, 2723.9727602724115, 2742.7394397532203, 2751.6010178524, 2752.2431331384028, 460.83870645274555, 467.0658682634731, 475.8239451403003, 479.09451137350436, 480.7884530806434, 530.3132443485696, 549.8900219956025, 556.894190103887, 557.2783245696833, 563.2171281918137, 6683.899741503881, 6923.826904327432, 6994.825129371705, 7000.859982800417, 7048.702375472165, 454.949067653721, 475.08071880910546, 494.29809670268304, 522.5532169994676, 545.585355130096, 3310.784798988058, 3428.4692133401777, 3448.9655103448645, 3472.878449254264, 3570.6072332043454, 90386.54806725924, 92634.0, 96147.0, 96179.0, 96279.51860240653, 53839.0, 81076.59461702654, 81274.59362703149, 83527.0, 84187.0, 43781.34327985083, 59332.70333648304, 62525.68737156376, 75146.62426687831, 75891.62054189804, 6842.0, 6843.931560684528, 6864.828379290558, 7023.0, 7198.244184360567, 45772.7711361441, 46180.53819461762, 47394.28908566443, 47410.288845666655, 47439.0, 35738.64261357353, 61577.0, 65340.0, 65984.0, 65998.0, 8648.481091134552, 8693.34799889998, 8735.388522803343, 8877.600507977028, 8972.37193396456, 8688.160969620112, 8975.237104846161, 9025.729228123168, 9066.22937050358, 9157.49633770149, 8103.8379232413845, 8372.204640559137, 8561.700340488052, 8604.139586041596, 8629.525376104375, 8643.524606146722, 8693.739187824376, 8733.912660873564, 9050.230730387992, 9177.77055573616, 8091.554964476775, 8227.753167404988, 8325.750227493185, 8335.95832020836, 8388.203120703523, 7339.9633001834645, 7496.400287977058, 7505.4746167767735, 7636.885446718415, 7711.652975615999, 6604.4056034955165, 7191.137063552198, 7201.675924583302, 7378.335949764547, 7391.963040184764], "value": 5938.371667325731, "unit": "score"}], "name": "dromaeo_css", "value": 6161.908621138498, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 115.0, 113.0, 112.0, 113.0, 115.0, 113.0, 115.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 122.0, 130.0, 175.0, 125.0, 131.0, 148.0, 124.0, 183.0, 127.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 162.0, 161.0, 163.0, 162.0, 163.0, 161.0, 164.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 123.0, 78.0, 79.0, 75.0, 77.0, 102.0, 78.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 112.0, 85.0, 85.0, 84.0, 116.0, 84.0, 85.0, 121.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 61.0, 63.0, 63.0, 63.0, 64.0, 62.0, 61.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 92.0, 85.0, 78.0, 78.0, 80.0, 80.0, 79.0, 81.0, 84.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 135.0, 138.0, 130.0, 128.0, 130.0, 129.0, 138.0, 170.0, 129.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 164.0, 165.0, 164.0, 172.0, 169.0, 163.0, 166.0, 164.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 68.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1533.8, "alertThreshold": 2.0}]} 03:17:36 INFO - Return code: 0 03:17:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:17:36 INFO - # TBPL SUCCESS # 03:17:36 INFO - Running post-action listener: _resource_record_post_action 03:17:36 INFO - [mozharness: 2016-07-27 10:17:36.508903Z] Finished run-tests step (success) 03:17:36 INFO - Running post-run listener: _resource_record_post_run 03:17:36 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 547581952; Read time: 0; Write time: 425684 03:17:36 INFO - TinderboxPrint: CPU usage
13.1% 03:17:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:17:36 INFO - TinderboxPrint: I/O write bytes / time
547,581,952 / 425,684 03:17:36 INFO - TinderboxPrint: CPU idle
8,332.6 (86.9%) 03:17:36 INFO - TinderboxPrint: CPU user
1,206.8 (12.6%) 03:17:36 INFO - TinderboxPrint: Swap in / out
0 / 0 03:17:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258842624; Read time: 0; Write time: 252236 03:17:36 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288739328; Read time: 0; Write time: 173448 03:17:37 INFO - Running post-run listener: _upload_blobber_files 03:17:37 INFO - Blob upload gear active. 03:17:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:17:37 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 03:17:37 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'] 03:17:37 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 03:17:37 INFO - (blobuploader) - INFO - Open directory for files ... 03:17:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:17:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:17:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:42 INFO - (blobuploader) - INFO - Done attempting. 03:17:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:17:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:17:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:42 INFO - (blobuploader) - INFO - Done attempting. 03:17:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:17:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:17:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:43 INFO - (blobuploader) - INFO - Done attempting. 03:17:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:17:43 INFO - Return code: 0 03:17:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:17:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:17:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ba7ceeebc150269cebea9504657f64990e65080c9820ffcccec668183eb731da7831eb58caf83ce8ab6ac2d6d325fd023ad11b8bfda5ca3c8966677638805c96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/095c28b2ba30cc3e1ca68ac557d053efc65c6f4e4481f1701cdb397f62bc8e15b96a849298760b98a700beb15e8196803bef1f49f40c922e09ef4c17225ebd7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c35a4f91bef7fcf8b34155d94d165820b9358074445362e6be8c148dd1090cab871399a19a06611a7fb640f6d92069fe6d18d2b55f0ff223469f2adcdb3636dc"} 03:17:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:17:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:17:43 INFO - Contents: 03:17:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ba7ceeebc150269cebea9504657f64990e65080c9820ffcccec668183eb731da7831eb58caf83ce8ab6ac2d6d325fd023ad11b8bfda5ca3c8966677638805c96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/095c28b2ba30cc3e1ca68ac557d053efc65c6f4e4481f1701cdb397f62bc8e15b96a849298760b98a700beb15e8196803bef1f49f40c922e09ef4c17225ebd7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c35a4f91bef7fcf8b34155d94d165820b9358074445362e6be8c148dd1090cab871399a19a06611a7fb640f6d92069fe6d18d2b55f0ff223469f2adcdb3636dc"} 03:17:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:17:43 INFO - Copying logs to upload dir... 03:17:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:17:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.246111 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-27 03:17:43.322012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 03:17:43.325316) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089 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/ba7ceeebc150269cebea9504657f64990e65080c9820ffcccec668183eb731da7831eb58caf83ce8ab6ac2d6d325fd023ad11b8bfda5ca3c8966677638805c96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/095c28b2ba30cc3e1ca68ac557d053efc65c6f4e4481f1701cdb397f62bc8e15b96a849298760b98a700beb15e8196803bef1f49f40c922e09ef4c17225ebd7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c35a4f91bef7fcf8b34155d94d165820b9358074445362e6be8c148dd1090cab871399a19a06611a7fb640f6d92069fe6d18d2b55f0ff223469f2adcdb3636dc"} build_url:https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/YJqcUD4STJO6rJYqOuXnHQ/artifacts/public/build/firefox-50.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/ba7ceeebc150269cebea9504657f64990e65080c9820ffcccec668183eb731da7831eb58caf83ce8ab6ac2d6d325fd023ad11b8bfda5ca3c8966677638805c96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/095c28b2ba30cc3e1ca68ac557d053efc65c6f4e4481f1701cdb397f62bc8e15b96a849298760b98a700beb15e8196803bef1f49f40c922e09ef4c17225ebd7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c35a4f91bef7fcf8b34155d94d165820b9358074445362e6be8c148dd1090cab871399a19a06611a7fb640f6d92069fe6d18d2b55f0ff223469f2adcdb3636dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 03:17:43.350280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:17:43.350571) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469612910.65327-2047225089 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-07-27 03:17:43.432838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 03:17:43.433166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 03:17:43.433468) ========= ========= Total master_lag: 0.17 =========