builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1470306300.17 results: success (0) buildid: 20160804023422 builduid: d13583c140f74bf191317d765f89404c revision: 510f0b4792de242447e6c80c693a621c8bf72d41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:00.171830) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:00.172279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:00.172610) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:00.187897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:00.188451) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 03:25:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-08-04 03:25:00 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:00.301375) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:00.301684) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018329 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:00.351077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:00.351552) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 510f0b4792de242447e6c80c693a621c8bf72d41 --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 510f0b4792de242447e6c80c693a621c8bf72d41 --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=74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 03:25:00,934 truncating revision to first 12 chars 2016-08-04 03:25:00,934 Setting DEBUG logging. 2016-08-04 03:25:00,934 attempt 1/10 2016-08-04 03:25:00,934 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/510f0b4792de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 03:25:01,246 unpacking tar archive at: fx-team-510f0b4792de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:01.004410) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:01.004711) ========= script_repo_revision: 510f0b4792de242447e6c80c693a621c8bf72d41 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:01.005107) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:01.005406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 03:25:01.013756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-04 03:25:01.014062) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:01 INFO - MultiFileLogger online at 20160804 03:25:01 in /builds/slave/test 03:25:01 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 03:25:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:01 INFO - {'append_to_log': False, 03:25:01 INFO - 'base_work_dir': '/builds/slave/test', 03:25:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:25:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:01 INFO - 'branch': 'Fx-Team-Non-PGO', 03:25:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:01 INFO - 'config_files': ('talos/linux_config.py',), 03:25:01 INFO - 'default_actions': ('clobber', 03:25:01 INFO - 'read-buildbot-config', 03:25:01 INFO - 'download-and-extract', 03:25:01 INFO - 'populate-webroot', 03:25:01 INFO - 'create-virtualenv', 03:25:01 INFO - 'install', 03:25:01 INFO - 'run-tests'), 03:25:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:01 INFO - 'download_minidump_stackwalk': True, 03:25:01 INFO - 'download_symbols': 'ondemand', 03:25:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:01 INFO - 'installer_path': 'installer.exe', 03:25:01 INFO - 'log_level': 'info', 03:25:01 INFO - 'log_name': 'talos', 03:25:01 INFO - 'log_to_console': True, 03:25:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:01 INFO - 'opt_config_files': (), 03:25:01 INFO - 'pip_index': False, 03:25:01 INFO - 'sps_profile': False, 03:25:01 INFO - 'sps_profile_interval': 0, 03:25:01 INFO - 'suite': 'dromaeojs', 03:25:01 INFO - 'system_bits': '32', 03:25:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:01 INFO - 'title': 'talos-linux64-ix-042', 03:25:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:01 INFO - 'use_talos_json': True, 03:25:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:01 INFO - 'work_dir': 'build'} 03:25:01 INFO - [mozharness: 2016-08-04 10:25:01.685697Z] Running clobber step. 03:25:01 INFO - Running pre-action listener: _resource_record_pre_action 03:25:01 INFO - Running main action method: clobber 03:25:01 INFO - rmtree: /builds/slave/test/build 03:25:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:02 INFO - Running post-action listener: _resource_record_post_action 03:25:02 INFO - [mozharness: 2016-08-04 10:25:02.147795Z] Finished clobber step (success) 03:25:02 INFO - [mozharness: 2016-08-04 10:25:02.147898Z] Running read-buildbot-config step. 03:25:02 INFO - Running pre-action listener: _resource_record_pre_action 03:25:02 INFO - Running main action method: read_buildbot_config 03:25:02 INFO - Using buildbot properties: 03:25:02 INFO - { 03:25:02 INFO - "project": "", 03:25:02 INFO - "product": "firefox", 03:25:02 INFO - "script_repo_revision": "production", 03:25:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:25:02 INFO - "repository": "", 03:25:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:25:02 INFO - "buildid": "20160804023422", 03:25:02 INFO - "pgo_build": "False", 03:25:02 INFO - "basedir": "/builds/slave/test", 03:25:02 INFO - "buildnumber": 2066, 03:25:02 INFO - "slavename": "talos-linux64-ix-042", 03:25:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:25:02 INFO - "platform": "ubuntu64_hw", 03:25:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:25:02 INFO - "branch": "fx-team", 03:25:02 INFO - "repo_path": "integration/fx-team", 03:25:02 INFO - "revision": "510f0b4792de242447e6c80c693a621c8bf72d41", 03:25:02 INFO - "stage_platform": "linux64", 03:25:02 INFO - "builduid": "d13583c140f74bf191317d765f89404c", 03:25:02 INFO - "slavebuilddir": "test" 03:25:02 INFO - } 03:25:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:25:02 INFO - Running post-action listener: _resource_record_post_action 03:25:02 INFO - [mozharness: 2016-08-04 10:25:02.150344Z] Finished read-buildbot-config step (success) 03:25:02 INFO - [mozharness: 2016-08-04 10:25:02.150433Z] Running download-and-extract step. 03:25:02 INFO - Running pre-action listener: _resource_record_pre_action 03:25:02 INFO - Running main action method: download_and_extract 03:25:02 INFO - mkdir: /builds/slave/test/build/tests 03:25:02 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')]} 03:25:02 INFO - https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:25:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:25:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:25:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:25:02 INFO - Downloaded 1361 bytes. 03:25:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:25:02 INFO - Using the following test package requirements: 03:25:02 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:25:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:25:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'jsshell-linux-x86_64.zip'], 03:25:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:25:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:25:02 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:25:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:02 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')]} 03:25:02 INFO - https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:25:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:25:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:04 INFO - Downloaded 20241066 bytes. 03:25:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:05 INFO - Return code: 0 03:25:05 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:25:05 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')]} 03:25:05 INFO - https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:25:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:25:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:08 INFO - Downloaded 20241066 bytes. 03:25:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:09 INFO - Return code: 0 03:25: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')]} 03:25:09 INFO - https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:25:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:25:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:25:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:25:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:25:10 INFO - Downloaded 14413723 bytes. 03:25:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:25:10 INFO - Return code: 0 03:25:10 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')]} 03:25:10 INFO - https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:25:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:25:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:25:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:25:12 INFO - Downloaded 55632844 bytes. 03:25:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:25:12 INFO - mkdir: /builds/slave/test/properties 03:25:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:12 INFO - Contents: 03:25:12 INFO - build_url:https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:25:12 INFO - Running post-action listener: _resource_record_post_action 03:25:12 INFO - Running post-action listener: set_extra_try_arguments 03:25:12 INFO - [mozharness: 2016-08-04 10:25:12.853488Z] Finished download-and-extract step (success) 03:25:12 INFO - [mozharness: 2016-08-04 10:25:12.853721Z] Running populate-webroot step. 03:25:12 INFO - Running pre-action listener: _resource_record_pre_action 03:25:12 INFO - Running main action method: populate_webroot 03:25:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:12 INFO - '--tppagecycles', 03:25:12 INFO - '7'], 03:25:12 INFO - 'tests': ['tsvgm']}}, 03:25:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:12 INFO - 'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:12 INFO - 'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['damp', 'tps']}, 03:25:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:12 INFO - 'tests': ['damp', 'tps']}, 03:25:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['dromaeo_dom']}, 03:25:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['basic_compositor_video']}, 03:25:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:25:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['a11yr', 03:25:12 INFO - 'ts_paint', 03:25:12 INFO - 'tpaint', 03:25:12 INFO - 'sessionrestore', 03:25:12 INFO - 'sessionrestore_no_auto_restore', 03:25:12 INFO - 'tabpaint']}, 03:25:12 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:12 INFO - 'ts_paint', 03:25:12 INFO - 'tpaint', 03:25:12 INFO - 'sessionrestore', 03:25:12 INFO - 'sessionrestore_no_auto_restore', 03:25:12 INFO - 'tabpaint']}, 03:25:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:12 INFO - 'ts_paint', 03:25:12 INFO - 'tpaint', 03:25:12 INFO - 'sessionrestore', 03:25:12 INFO - 'sessionrestore_no_auto_restore', 03:25:12 INFO - 'tabpaint']}, 03:25:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:12 INFO - 'ts_paint', 03:25:12 INFO - 'tpaint', 03:25:12 INFO - 'sessionrestore', 03:25:12 INFO - 'sessionrestore_no_auto_restore', 03:25:12 INFO - 'tabpaint']}, 03:25:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['a11yr', 03:25:12 INFO - 'ts_paint', 03:25:12 INFO - 'tpaint', 03:25:12 INFO - 'sessionrestore', 03:25:12 INFO - 'sessionrestore_no_auto_restore', 03:25:12 INFO - 'tabpaint']}, 03:25:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['a11yr', 03:25:12 INFO - 'ts_paint', 03:25:12 INFO - 'tpaint', 03:25:12 INFO - 'sessionrestore', 03:25:12 INFO - 'sessionrestore_no_auto_restore', 03:25:12 INFO - 'tabpaint']}, 03:25:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['tsvgx', 03:25:12 INFO - 'tsvgr_opacity', 03:25:12 INFO - 'tart', 03:25:12 INFO - 'tscrollx', 03:25:12 INFO - 'cart']}, 03:25:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:12 INFO - 'tsvgr_opacity', 03:25:12 INFO - 'tart', 03:25:12 INFO - 'tscrollx', 03:25:12 INFO - 'cart']}, 03:25:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:12 INFO - 'talos_options': ['--disable-e10s'], 03:25:12 INFO - 'tests': ['tp5o']}, 03:25:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:12 INFO - 'tests': ['tp5o']}, 03:25:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:12 INFO - 'talos_options': ['--disable-e10s', 03:25:12 INFO - '--xperf_path', 03:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:12 INFO - 'tests': ['tp5n']}, 03:25:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:12 INFO - 'talos_options': ['--xperf_path', 03:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:12 INFO - 'tests': ['tp5n']}}, 03:25:12 INFO - 'talos.zip': {'path': '', 03:25:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:12 INFO - Running post-action listener: _resource_record_post_action 03:25:12 INFO - [mozharness: 2016-08-04 10:25:12.868933Z] Finished populate-webroot step (success) 03:25:12 INFO - [mozharness: 2016-08-04 10:25:12.869022Z] Running create-virtualenv step. 03:25:12 INFO - Running pre-action listener: _resource_record_pre_action 03:25:12 INFO - Running main action method: create_virtualenv 03:25:12 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:12 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 03:25:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:12 INFO - Using real prefix '/usr' 03:25:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:13 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:15 INFO - Installing pip.................done. 03:25:15 INFO - Return code: 0 03:25:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25:15 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 03:25:15 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 03:25:15 INFO - Using env: {'DISPLAY': ':0', 03:25:15 INFO - 'HOME': '/home/cltbld', 03:25:15 INFO - 'LANG': 'en_US.UTF-8', 03:25:15 INFO - 'LANGUAGE': 'en_US:en', 03:25:15 INFO - 'LOGNAME': 'cltbld', 03:25:15 INFO - 'MAIL': '/var/mail/cltbld', 03:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:15 INFO - 'MOZ_NO_REMOTE': '1', 03:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:15 INFO - 'NO_EM_RESTART': '1', 03:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:15 INFO - 'PWD': '/builds/slave/test', 03:25:15 INFO - 'SHELL': '/bin/bash', 03:25:15 INFO - 'SHLVL': '1', 03:25:15 INFO - 'TERM': 'linux', 03:25:15 INFO - 'TMOUT': '86400', 03:25:15 INFO - 'USER': 'cltbld', 03:25:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:15 INFO - '_': '/tools/buildbot/bin/python'} 03:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:15 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 03:25:15 INFO - Cleaning up... 03:25:15 INFO - Return code: 0 03:25:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25:15 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 03:25:15 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 03:25:15 INFO - Using env: {'DISPLAY': ':0', 03:25:15 INFO - 'HOME': '/home/cltbld', 03:25:15 INFO - 'LANG': 'en_US.UTF-8', 03:25:15 INFO - 'LANGUAGE': 'en_US:en', 03:25:15 INFO - 'LOGNAME': 'cltbld', 03:25:15 INFO - 'MAIL': '/var/mail/cltbld', 03:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:15 INFO - 'MOZ_NO_REMOTE': '1', 03:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:15 INFO - 'NO_EM_RESTART': '1', 03:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:15 INFO - 'PWD': '/builds/slave/test', 03:25:15 INFO - 'SHELL': '/bin/bash', 03:25:15 INFO - 'SHLVL': '1', 03:25:15 INFO - 'TERM': 'linux', 03:25:15 INFO - 'TMOUT': '86400', 03:25:15 INFO - 'USER': 'cltbld', 03:25:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:15 INFO - '_': '/tools/buildbot/bin/python'} 03:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:15 INFO - Downloading/unpacking psutil>=3.1.1 03:25:15 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 03:25:15 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 03:25:15 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 03:25:15 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 03:25:15 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 03:25:15 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 03:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:18 INFO - Installing collected packages: psutil 03:25:18 INFO - Running setup.py install for psutil 03:25:18 INFO - building 'psutil._psutil_linux' extension 03:25: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 03:25: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 03:25:18 INFO - building 'psutil._psutil_posix' extension 03:25: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 03:25: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 03:25:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:18 INFO - Successfully installed psutil 03:25:18 INFO - Cleaning up... 03:25:18 INFO - Return code: 0 03:25:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:18 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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25:18 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 03:25:18 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 03:25:18 INFO - Using env: {'DISPLAY': ':0', 03:25:18 INFO - 'HOME': '/home/cltbld', 03:25:18 INFO - 'LANG': 'en_US.UTF-8', 03:25:18 INFO - 'LANGUAGE': 'en_US:en', 03:25:18 INFO - 'LOGNAME': 'cltbld', 03:25:18 INFO - 'MAIL': '/var/mail/cltbld', 03:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:18 INFO - 'MOZ_NO_REMOTE': '1', 03:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:18 INFO - 'NO_EM_RESTART': '1', 03:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:18 INFO - 'PWD': '/builds/slave/test', 03:25:18 INFO - 'SHELL': '/bin/bash', 03:25:18 INFO - 'SHLVL': '1', 03:25:18 INFO - 'TERM': 'linux', 03:25:18 INFO - 'TMOUT': '86400', 03:25:18 INFO - 'USER': 'cltbld', 03:25:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:18 INFO - '_': '/tools/buildbot/bin/python'} 03:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:18 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 03:25:18 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 03:25:18 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 03:25:18 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 03:25:18 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 03:25:18 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 03:25:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:21 INFO - Installing collected packages: mozsystemmonitor 03:25:21 INFO - Running setup.py install for mozsystemmonitor 03:25:21 INFO - Successfully installed mozsystemmonitor 03:25:21 INFO - Cleaning up... 03:25:21 INFO - Return code: 0 03:25:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25: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 03:25: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 03:25:21 INFO - Using env: {'DISPLAY': ':0', 03:25:21 INFO - 'HOME': '/home/cltbld', 03:25:21 INFO - 'LANG': 'en_US.UTF-8', 03:25:21 INFO - 'LANGUAGE': 'en_US:en', 03:25:21 INFO - 'LOGNAME': 'cltbld', 03:25:21 INFO - 'MAIL': '/var/mail/cltbld', 03:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:21 INFO - 'MOZ_NO_REMOTE': '1', 03:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:21 INFO - 'NO_EM_RESTART': '1', 03:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:21 INFO - 'PWD': '/builds/slave/test', 03:25:21 INFO - 'SHELL': '/bin/bash', 03:25:21 INFO - 'SHLVL': '1', 03:25:21 INFO - 'TERM': 'linux', 03:25:21 INFO - 'TMOUT': '86400', 03:25:21 INFO - 'USER': 'cltbld', 03:25:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:21 INFO - '_': '/tools/buildbot/bin/python'} 03:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:22 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:24 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:24 INFO - warning: no files found matching '*.txt' 03:25:24 INFO - no previously-included directories found matching 'build' 03:25:24 INFO - no previously-included directories found matching 'dist' 03:25:24 INFO - no previously-included directories found matching '.git*' 03:25:24 INFO - Installing collected packages: jsonschema, functools32 03:25:24 INFO - Running setup.py install for functools32 03:25:24 INFO - warning: no files found matching '*.txt' 03:25:24 INFO - no previously-included directories found matching 'build' 03:25:24 INFO - no previously-included directories found matching 'dist' 03:25:24 INFO - no previously-included directories found matching '.git*' 03:25:24 INFO - Successfully installed jsonschema functools32 03:25:24 INFO - Cleaning up... 03:25:24 INFO - Return code: 0 03:25:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25: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 03:25: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 03:25:24 INFO - Using env: {'DISPLAY': ':0', 03:25:24 INFO - 'HOME': '/home/cltbld', 03:25:24 INFO - 'LANG': 'en_US.UTF-8', 03:25:24 INFO - 'LANGUAGE': 'en_US:en', 03:25:24 INFO - 'LOGNAME': 'cltbld', 03:25:24 INFO - 'MAIL': '/var/mail/cltbld', 03:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:24 INFO - 'MOZ_NO_REMOTE': '1', 03:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:24 INFO - 'NO_EM_RESTART': '1', 03:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:24 INFO - 'PWD': '/builds/slave/test', 03:25:24 INFO - 'SHELL': '/bin/bash', 03:25:24 INFO - 'SHLVL': '1', 03:25:24 INFO - 'TERM': 'linux', 03:25:24 INFO - 'TMOUT': '86400', 03:25:24 INFO - 'USER': 'cltbld', 03:25:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:24 INFO - '_': '/tools/buildbot/bin/python'} 03:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:24 INFO - Cleaning up... 03:25:24 INFO - Return code: 0 03:25:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25: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 03:25: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 03:25:24 INFO - Using env: {'DISPLAY': ':0', 03:25:24 INFO - 'HOME': '/home/cltbld', 03:25:24 INFO - 'LANG': 'en_US.UTF-8', 03:25:24 INFO - 'LANGUAGE': 'en_US:en', 03:25:24 INFO - 'LOGNAME': 'cltbld', 03:25:24 INFO - 'MAIL': '/var/mail/cltbld', 03:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:24 INFO - 'MOZ_NO_REMOTE': '1', 03:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:24 INFO - 'NO_EM_RESTART': '1', 03:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:24 INFO - 'PWD': '/builds/slave/test', 03:25:24 INFO - 'SHELL': '/bin/bash', 03:25:24 INFO - 'SHLVL': '1', 03:25:24 INFO - 'TERM': 'linux', 03:25:24 INFO - 'TMOUT': '86400', 03:25:24 INFO - 'USER': 'cltbld', 03:25:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:24 INFO - '_': '/tools/buildbot/bin/python'} 03:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:27 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 03:25:27 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 03:25:27 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 03:25:27 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 03:25:27 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 03:25:27 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 03:25:27 INFO - Downloading docopt-0.6.1.tar.gz 03:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:27 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:27 INFO - Running setup.py install for blobuploader 03:25:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:27 INFO - Running setup.py install for requests 03:25:27 INFO - Running setup.py install for docopt 03:25:28 INFO - Successfully installed blobuploader requests docopt 03:25:28 INFO - Cleaning up... 03:25:28 INFO - Return code: 0 03:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:28 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')]} 03:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:28 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')]} 03:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:28 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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25:28 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 03:25:28 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 03:25:28 INFO - Using env: {'DISPLAY': ':0', 03:25:28 INFO - 'HOME': '/home/cltbld', 03:25:28 INFO - 'LANG': 'en_US.UTF-8', 03:25:28 INFO - 'LANGUAGE': 'en_US:en', 03:25:28 INFO - 'LOGNAME': 'cltbld', 03:25:28 INFO - 'MAIL': '/var/mail/cltbld', 03:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:28 INFO - 'MOZ_NO_REMOTE': '1', 03:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:28 INFO - 'NO_EM_RESTART': '1', 03:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:28 INFO - 'PWD': '/builds/slave/test', 03:25:28 INFO - 'SHELL': '/bin/bash', 03:25:28 INFO - 'SHLVL': '1', 03:25:28 INFO - 'TERM': 'linux', 03:25:28 INFO - 'TMOUT': '86400', 03:25:28 INFO - 'USER': 'cltbld', 03:25:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:28 INFO - '_': '/tools/buildbot/bin/python'} 03:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:28 INFO - Running setup.py (path:/tmp/pip-9lGloL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:28 INFO - Running setup.py (path:/tmp/pip-15c5p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:28 INFO - Running setup.py (path:/tmp/pip-kAwkVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:28 INFO - Running setup.py (path:/tmp/pip-nJTg8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:28 INFO - Running setup.py (path:/tmp/pip-sU9PNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:28 INFO - Running setup.py (path:/tmp/pip-Gwtpvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:28 INFO - Running setup.py (path:/tmp/pip-C2Rt7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:28 INFO - Running setup.py (path:/tmp/pip-8DGzjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:28 INFO - Running setup.py (path:/tmp/pip-MVjrh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:28 INFO - Running setup.py (path:/tmp/pip-644uJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:29 INFO - Running setup.py (path:/tmp/pip-6MNReV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:29 INFO - Running setup.py (path:/tmp/pip-fzNzSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:29 INFO - Running setup.py (path:/tmp/pip-aengyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:29 INFO - Running setup.py (path:/tmp/pip-hdU89t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:29 INFO - Running setup.py (path:/tmp/pip-vVaVNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:29 INFO - Running setup.py (path:/tmp/pip-Ey48X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:29 INFO - Running setup.py (path:/tmp/pip-VoCDon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:29 INFO - Running setup.py install for manifestparser 03:25:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:29 INFO - Running setup.py install for mozcrash 03:25:29 INFO - Running setup.py install for mozdebug 03:25:29 INFO - Running setup.py install for mozdevice 03:25:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:25:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:29 INFO - Running setup.py install for mozfile 03:25:30 INFO - Running setup.py install for mozhttpd 03:25:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Running setup.py install for mozinfo 03:25:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Running setup.py install for mozInstall 03:25:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Running setup.py install for mozleak 03:25:30 INFO - Running setup.py install for mozlog 03:25:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Running setup.py install for moznetwork 03:25:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Running setup.py install for mozprocess 03:25:30 INFO - Running setup.py install for mozprofile 03:25:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:30 INFO - Running setup.py install for mozrunner 03:25:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:31 INFO - Running setup.py install for mozscreenshot 03:25:31 INFO - Running setup.py install for moztest 03:25:31 INFO - Running setup.py install for mozversion 03:25:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:31 INFO - Cleaning up... 03:25:31 INFO - Return code: 0 03:25:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:31 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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25:31 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 03:25:31 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 03:25:31 INFO - Using env: {'DISPLAY': ':0', 03:25:31 INFO - 'HOME': '/home/cltbld', 03:25:31 INFO - 'LANG': 'en_US.UTF-8', 03:25:31 INFO - 'LANGUAGE': 'en_US:en', 03:25:31 INFO - 'LOGNAME': 'cltbld', 03:25:31 INFO - 'MAIL': '/var/mail/cltbld', 03:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:31 INFO - 'MOZ_NO_REMOTE': '1', 03:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:31 INFO - 'NO_EM_RESTART': '1', 03:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:31 INFO - 'PWD': '/builds/slave/test', 03:25:31 INFO - 'SHELL': '/bin/bash', 03:25:31 INFO - 'SHLVL': '1', 03:25:31 INFO - 'TERM': 'linux', 03:25:31 INFO - 'TMOUT': '86400', 03:25:31 INFO - 'USER': 'cltbld', 03:25:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:31 INFO - '_': '/tools/buildbot/bin/python'} 03:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:31 INFO - Running setup.py (path:/tmp/pip-NDfFDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25: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)) 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:31 INFO - Running setup.py (path:/tmp/pip-qOTz7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25: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)) 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:31 INFO - Running setup.py (path:/tmp/pip-IFN50X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25: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)) 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:31 INFO - Running setup.py (path:/tmp/pip-_gCuHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25: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)) 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:31 INFO - Running setup.py (path:/tmp/pip-aGub44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25: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)) 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:31 INFO - Running setup.py (path:/tmp/pip-jL9AS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25: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)) 03:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:31 INFO - Running setup.py (path:/tmp/pip-7NC_pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:32 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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:32 INFO - Running setup.py (path:/tmp/pip-eTUmsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:32 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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:32 INFO - Running setup.py (path:/tmp/pip-_6qz07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:32 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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:32 INFO - Running setup.py (path:/tmp/pip-FNcYsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:32 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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:32 INFO - Running setup.py (path:/tmp/pip-jkRweH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25: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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:32 INFO - Running setup.py (path:/tmp/pip-oAUkbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25: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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:32 INFO - Running setup.py (path:/tmp/pip-jYlI8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25: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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:32 INFO - Running setup.py (path:/tmp/pip-ej9ZDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25: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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:32 INFO - Running setup.py (path:/tmp/pip-Pnd0cV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25: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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:32 INFO - Running setup.py (path:/tmp/pip-n_bmXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25: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)) 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:32 INFO - Running setup.py (path:/tmp/pip-g09Tvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:34 INFO - Downloading blessings-1.6.tar.gz 03:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:34 INFO - Installing collected packages: blessings 03:25:34 INFO - Running setup.py install for blessings 03:25:34 INFO - Successfully installed blessings 03:25:34 INFO - Cleaning up... 03:25:34 INFO - Return code: 0 03:25:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:35 INFO - Reading from file tmpfile_stdout 03:25:35 INFO - Current package versions: 03:25:35 INFO - argparse == 1.2.1 03:25:35 INFO - blessings == 1.6 03:25:35 INFO - blobuploader == 1.2.4 03:25:35 INFO - docopt == 0.6.1 03:25:35 INFO - functools32 == 3.2.3-2 03:25:35 INFO - jsonschema == 2.5.1 03:25:35 INFO - manifestparser == 1.1 03:25:35 INFO - mozInstall == 1.12 03:25:35 INFO - mozcrash == 0.17 03:25:35 INFO - mozdebug == 0.1 03:25:35 INFO - mozdevice == 0.48 03:25:35 INFO - mozfile == 1.2 03:25:35 INFO - mozhttpd == 0.7 03:25:35 INFO - mozinfo == 0.9 03:25:35 INFO - mozleak == 0.1 03:25:35 INFO - mozlog == 3.3 03:25:35 INFO - moznetwork == 0.27 03:25:35 INFO - mozprocess == 0.23 03:25:35 INFO - mozprofile == 0.28 03:25:35 INFO - mozrunner == 6.12 03:25:35 INFO - mozscreenshot == 0.1 03:25:35 INFO - mozsystemmonitor == 0.3 03:25:35 INFO - moztest == 0.7 03:25:35 INFO - mozversion == 1.4 03:25:35 INFO - psutil == 3.1.1 03:25:35 INFO - requests == 1.2.3 03:25:35 INFO - wsgiref == 0.1.2 03:25:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:35 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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25:35 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 03:25:35 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 03:25:35 INFO - Using env: {'DISPLAY': ':0', 03:25:35 INFO - 'HOME': '/home/cltbld', 03:25:35 INFO - 'LANG': 'en_US.UTF-8', 03:25:35 INFO - 'LANGUAGE': 'en_US:en', 03:25:35 INFO - 'LOGNAME': 'cltbld', 03:25:35 INFO - 'MAIL': '/var/mail/cltbld', 03:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:35 INFO - 'MOZ_NO_REMOTE': '1', 03:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:35 INFO - 'NO_EM_RESTART': '1', 03:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:35 INFO - 'PWD': '/builds/slave/test', 03:25:35 INFO - 'SHELL': '/bin/bash', 03:25:35 INFO - 'SHLVL': '1', 03:25:35 INFO - 'TERM': 'linux', 03:25:35 INFO - 'TMOUT': '86400', 03:25:35 INFO - 'USER': 'cltbld', 03:25:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:35 INFO - '_': '/tools/buildbot/bin/python'} 03:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25: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)) 03:25:35 INFO - Cleaning up... 03:25:35 INFO - Return code: 0 03:25:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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 0xbaa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', '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 03:25: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 03:25: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 03:25:35 INFO - Using env: {'DISPLAY': ':0', 03:25:35 INFO - 'HOME': '/home/cltbld', 03:25:35 INFO - 'LANG': 'en_US.UTF-8', 03:25:35 INFO - 'LANGUAGE': 'en_US:en', 03:25:35 INFO - 'LOGNAME': 'cltbld', 03:25:35 INFO - 'MAIL': '/var/mail/cltbld', 03:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:35 INFO - 'MOZ_NO_REMOTE': '1', 03:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:35 INFO - 'NO_EM_RESTART': '1', 03:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:35 INFO - 'PWD': '/builds/slave/test', 03:25:35 INFO - 'SHELL': '/bin/bash', 03:25:35 INFO - 'SHLVL': '1', 03:25:35 INFO - 'TERM': 'linux', 03:25:35 INFO - 'TMOUT': '86400', 03:25:35 INFO - 'USER': 'cltbld', 03:25:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:35 INFO - '_': '/tools/buildbot/bin/python'} 03:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:25:35 INFO - Cleaning up... 03:25:35 INFO - Return code: 0 03:25:35 INFO - Running post-action listener: _resource_record_post_action 03:25:35 INFO - Running post-action listener: _start_resource_monitoring 03:25:35 INFO - Starting resource monitoring. 03:25:35 INFO - [mozharness: 2016-08-04 10:25:35.575924Z] Finished create-virtualenv step (success) 03:25:35 INFO - [mozharness: 2016-08-04 10:25:35.576399Z] Running install step. 03:25:35 INFO - Running pre-action listener: _resource_record_pre_action 03:25:35 INFO - Running main action method: install 03:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:35 INFO - Reading from file tmpfile_stdout 03:25:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:25:35 INFO - Reading from file tmpfile_stdout 03:25:35 INFO - Output received: 03:25:35 INFO - Usage: mozinstall [options] installer 03:25:35 INFO - Options: 03:25:35 INFO - -h, --help show this help message and exit 03:25:35 INFO - -d DEST, --destination=DEST 03:25:35 INFO - Directory to install application into. [default: 03:25:35 INFO - "/builds/slave/test"] 03:25:35 INFO - --app=APP Application being installed. [default: firefox] 03:25:35 INFO - mkdir: /builds/slave/test/build/application 03:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:25:51 INFO - Reading from file tmpfile_stdout 03:25:51 INFO - Output received: 03:25:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:25:51 INFO - Running post-action listener: _resource_record_post_action 03:25:51 INFO - [mozharness: 2016-08-04 10:25:51.862153Z] Finished install step (success) 03:25:51 INFO - [mozharness: 2016-08-04 10:25:51.862431Z] Running run-tests step. 03:25:51 INFO - Running pre-action listener: _resource_record_pre_action 03:25:51 INFO - Running main action method: run_tests 03:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:25:51 INFO - Python 2.7.3 03:25:51 INFO - Return code: 0 03:25:51 INFO - grabbing minidump binary from tooltool 03:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:51 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 0xe693b0>, '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 0xe6a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:25:51 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 03:25:51 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 03:25:51 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 03:25:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:51 INFO - Return code: 0 03:25:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:25:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:25:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:25:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:25:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:25:51 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/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 03:25:51 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/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 03:25:51 INFO - Using env: {'DISPLAY': ':0', 03:25:51 INFO - 'HOME': '/home/cltbld', 03:25:51 INFO - 'LANG': 'en_US.UTF-8', 03:25:51 INFO - 'LANGUAGE': 'en_US:en', 03:25:51 INFO - 'LOGNAME': 'cltbld', 03:25:51 INFO - 'MAIL': '/var/mail/cltbld', 03:25:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:51 INFO - 'MOZ_NO_REMOTE': '1', 03:25:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:51 INFO - 'NO_EM_RESTART': '1', 03:25:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:51 INFO - 'PWD': '/builds/slave/test', 03:25:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:51 INFO - 'SHELL': '/bin/bash', 03:25:51 INFO - 'SHLVL': '1', 03:25:51 INFO - 'TERM': 'linux', 03:25:51 INFO - 'TMOUT': '86400', 03:25:51 INFO - 'USER': 'cltbld', 03:25:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958', 03:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:51 INFO - '_': '/tools/buildbot/bin/python'} 03:25:51 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/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 03:25:52 INFO - mozversion application_buildid: 20160804023422 03:25:52 INFO - mozversion application_changeset: 510f0b4792de242447e6c80c693a621c8bf72d41 03:25:52 INFO - mozversion application_display_name: Nightly 03:25:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:52 INFO - mozversion application_name: Firefox 03:25:52 INFO - mozversion application_remotingname: firefox 03:25:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:25:52 INFO - mozversion application_vendor: Mozilla 03:25:52 INFO - mozversion application_version: 51.0a1 03:25:52 INFO - mozversion platform_buildid: 20160804023422 03:25:52 INFO - mozversion platform_changeset: 510f0b4792de242447e6c80c693a621c8bf72d41 03:25:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:25:52 INFO - mozversion platform_version: 51.0a1 03:25:52 INFO - using testdate: 1470306352 03:25:52 INFO - actual date: 1470306352 03:25:52 INFO - starting webserver on 'localhost:54950' 03:25:52 INFO - SUITE-START | Running 2 tests 03:25:52 INFO - TEST-START | dromaeo_css 03:25:52 INFO - operating with platform_type : linux_ 03:25:52 INFO - Initialising browser for dromaeo_css test... 03:25:52 INFO - TEST-INFO | started process 12782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOZktkM/profile http://localhost:54950/getInfo.html) 03:25:56 INFO - PROCESS | 12782 | __metrics Screen width/height:1600/1200 03:25:56 INFO - PROCESS | 12782 | colorDepth:24 03:25:56 INFO - PROCESS | 12782 | Browser inner width/height: 1024/697 03:25:56 INFO - PROCESS | 12782 | __metrics 03:25:57 INFO - PROCESS | 12782 | 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:25:57 INFO - PROCESS | 12782 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:25:58 INFO - TEST-INFO | 12782: exit 0 03:25:58 INFO - Browser initialized. 03:25:58 INFO - Running cycle 1/1 for dromaeo_css test... 03:25:58 INFO - TEST-INFO | started process 12862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOZktkM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:10 INFO - PROCESS | 12862 | RSS: Main: 157716480 03:26:10 INFO - PROCESS | 12862 | 03:27:01 INFO - PROCESS | 12862 | 1470306421179 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:29:14 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:54950/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54950/tests/dromaeo/cssquery-ext.html) 03:29:15 INFO - PROCESS | 12862 | RSS: Main: 244436992 03:29:15 INFO - PROCESS | 12862 | 03:32:18 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:54950/tests/dromaeo/cssquery-ext.html (next: http://localhost:54950/tests/dromaeo/cssquery-jquery.html) 03:32:19 INFO - PROCESS | 12862 | RSS: Main: 242024448 03:32:19 INFO - PROCESS | 12862 | 03:35:21 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:54950/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54950/tests/dromaeo/cssquery-mootools.html) 03:35:21 INFO - PROCESS | 12862 | RSS: Main: 229675008 03:35:21 INFO - PROCESS | 12862 | 03:38:24 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:54950/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54950/tests/dromaeo/cssquery-prototype.html) 03:38:24 INFO - PROCESS | 12862 | RSS: Main: 190144512 03:38:24 INFO - PROCESS | 12862 | 03:41:27 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:54950/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54950/tests/dromaeo/cssquery-yui.html) 03:41:28 INFO - PROCESS | 12862 | RSS: Main: 189448192 03:41:28 INFO - PROCESS | 12862 | 03:44:31 INFO - PROCESS | 12862 | Cycle 1(1): loaded http://localhost:54950/tests/dromaeo/cssquery-yui.html (next: http://localhost:54950/tests/dromaeo/cssquery-dojo.html) 03:44:31 INFO - PROCESS | 12862 | RSS: Main: 280064000 03:44:31 INFO - PROCESS | 12862 | 03:44:31 INFO - PROCESS | 12862 | __start_tp_report 03:44:31 INFO - PROCESS | 12862 | _x_x_mozilla_page_load 03:44:31 INFO - PROCESS | 12862 | _x_x_mozilla_page_load_details 03:44:31 INFO - PROCESS | 12862 | |i|pagename|runs| 03:44:31 INFO - PROCESS | 12862 | |0;dojo.html;2609.765121139097;2655.8539280339587;2659.8138130330885;2684.342336127649;2719.72802719728;4671.112488627167;4726.716397016182;4802.207635740103;4957.082939656166;4974.4030716314;4809.855704328876;4851.587615052725;4866.051120031595;4895.069936712022;4900.313956046157;4370.5410931852175;4428.1807865544815;4468.664850136252;4525.683202175849;4609.815607375717;4530.637548996089;4562.954370456286;4574.565416285448;4593.5406459354135;4594.816207351702;4326;4366.607005369532;4367.45406824147;4429.313456414261;4468.731876087445;4411.183930972748;4438.800253988578;4448.888777780581;4535.546445355471;4541.636669066466;4459.197344477992;4468.084042771224;4482.327650852366;4511.345854851061;4512.097580483916;4716.316134160562;4904.0437114762635;4907.779149938261;4958.00839832035;4958.2562615607585;5166.896662066775;5210.947890521084;5222.242774797671;5283.867903302448;5295.179247216649;5244.475552444763;5259.500347467023;5304.177852432879;5314.813981510629;5325.227841962894;4749.35883655702;4903.5586797188425;4926.778294976734;4939.407271127488;4943.8516844494725;5282.234076059027;5314.867128321823;5345.786168553214;5452.154915988028;5453.454654534594;5169.844904652867;5183.352080989876;5228.189630607186;5231.529162375405;5236.816711415082;5034.0686972910125;5311.468853114658;5320.574354051667;5321.73391330432;5330.067238233371;5106.642535022513;5168.043911876315;5178.870528236749;5267.473252674778;5273.1035723927025;5201.7919283229;5204.8959020819375;5205.609579281493;5212.139996900545;5254.710990895537;4478.484974228006;4479.776011199427;4480.193565158303;4511.503734589192;4528.705634133771;3832.80835958201;3847.480590120354;3847.74989625679;3882.417637354363;3885.3006458837117;4438.245498265303;4449.688521803443;4472.105578884236;4481.910361792811;4496.19068567661;5223.5037671421915;5253.684778913277;5258.710770907637;5267.051930652443;5267.762950667229;4296.656267498593;4368.716033457815;4406.713563618418;4454.532274111237;4490.034642551867;4708.128996135726;4724.929126063112;4730.408698912636;4753.9762301188275;4780.808767649255;4892.804287828447;4896.485868983706;4897.706137631753;4899.730514821719;4936.580390666762;4946.901061978812;5169.043726910533;5191.558717509054;5258.50044245796;5290.338707661543;4889.46215916256;4902.093112774148;4907.116718990616;4936.555709986119;4953.900921981613;5163.302954101298;5176.922346164886;5178.0679477694375;5180.663256888291;5228;4992.101421744121;5118.41138269089;5118.641695081457;5242.108841496878;5253.842384728464;5036.546710796046;5039.269305950544;5041.873953151201;5077.568406685473;5094.414142373526;5022.573081288131;5037.949620503895;5039.420466646383;5060.49395060491;5085.694858308513;4810.975945120252;4874.5856602189215;4944.92582611254;4978.626603004716;5032.0690672225755;5078.746062696924;5084.491550844886;5093.4651861554;5116.9744151279;5130.204818253177;4935.679180853233;4969.552740253394;4971.701697898137;4976.825811096594;5031.798728050837 03:44:31 INFO - PROCESS | 12862 | |1;ext.html;560.1597603594608;565.8274226360958;569.1576466829096;580.2167074449494;585.1252377695346;29862.253443663918;40507.59492405075;42008.15983680324;42012.15975680488;45659.54340456594;41973.37039944403;42314;42576.14847703044;42606.57393426065;42622.57377426225;7687.461877668551;7797.337226335769;7825.6087195640275;7829.138794732575;7829.608519573999;7467.813304667372;9503.80992380152;9725.0761177688;9735;10003.549840257207;9971.60113595459;10024.799504009952;10046.799064018714;10048.598056077748;10051.748706282366;9859.161971232383;9864.802703945918;9906.752331191707;9934.35426697266;9938;9823.607055717834;9877.753056173582;9883.950580247052;9887.060729230712;9896.059874311928;38430.231395371935;38605.80697096525;38794.418083728764;38827.611723882685;38840.41739373912;3099.6900309969046;3105.8602362893726;3204.7275981541598;3231.951520727191;3332.9833350833333;29817.25456863574;30143;30411.2397190072;30503.084907452812;30625.693743062508;3229.1119942016135;3281.2453135778665;3295.0773783340464;3304.80171189727;3307.6361600223954;238560;241939;243122;243341;244399;54658;55034;55133;55174;55232.72383638056;57875.71062144746;57935;58156.709216454496;58248;58334.4166558329;14778.334974926154;15065.623359416102;15071.171085590178;15082.773758393632;15083.321250543751;9231.215346695471;9715.02849715037;9746.561404736804;9820.508974551243;10594.4702764863;16242.918785405996;16925.830741692673;17032.65934681324;17048.57378565521;17247;5508.097792964185;5510.29995302299;5521.889562208814;5552.91670624941;5680.68756218412;803;878.499255424402;888.8313808239337;919.6597259014208;920.9823145424343;28215.57676634852;28335.149945501667;28423.857880710464;28746.137615871558;28815.855920720263;996.257787947969;999.5052449037773;1009.4750729620556;1012.5595366015807;1032.992831988805;15029.549113526611;15288.770668439982;15390.615234619225;15594.454194103151;15739.763903541456;363354;375799;376249;376769;377614;48654.270185947236;48938.75530622395;48989.755051224514;49002.26496602554;49035.5096449031;1098.8351747237978;1178.9233699809486;1184.466989854586;1205.4394706461537;1208.2689972566645;26853.194404167905;29138.708612914448;29313.267168320963;29677;29908.850455747583;42573;43313;43479.782601086794;43569.56430435782;43688.78155609201;312404;316012;317216;317496;317581;32288.515672265406;33356;36830;37140;37632.81183594064;38393.23213535769;41350;41654;41986;42497.36253956131;34191.264698823536;34909.127271818405;35534;35562.64437355593;35628.82185589159;35747.82126089353;35854;35907.64092359043;36143.81928090448;36348.818255908554;34732.47901281432;35015.82492087523;35158.12104697403;35256.471152932216;35869.82065089658;30280;32657.836710817246;32818;32852;33009.174770630925;24692.753072469044;25225.369365766004;25253.494930101664;25516.362090947874;25548.23355299344 03:44:31 INFO - PROCESS | 12862 | |2;jquery.html;339.9048266485382;346.4237718381365;350.95963964144113;355.7708118450753;371.2908345060934;13018.869811301884;16461.094639794806;16472.094034828093;17106.914465427657;18094.638107237846;16429.753553696704;16711.498655040337;16925.238364273606;16961.66076678466;16994.235259413326;4926.359573255471;4926.852194434164;5092.9236061459105;5106.336176297076;5110.28456016158;3681.4845921571;4792.90414191716;5053.267276244942;5551.2228288039505;5850.795222167225;5860.73626686798;5877;5893.351731309553;5904.586678932476;5907.556933230004;5082.23766435034;5279.9208011879855;5294.1529355303355;5428.077226871442;5901.026330655437;5259.316288882459;5263.0526505229045;5275;5275.419703832576;5279.86800329991;11659.12556558253;11696.941515292454;11860.110491713156;11900.702482437922;12021.639350819489;1905.7141428785656;1961.2155137944794;1978.357033963953;1985.9510874972684;2049.7847725988854;8660.090690477535;9449.716508504756;9676;11753.824617538177;12935.353232338439;1718.9656206875918;1738.6435780664933;1766.0816375484676;1789.910504474771;1822.7812662480587;65428.67285663589;66563;68537.65731171361;68701.31298686999;71003.28996710018;9536.28477864163;9581.856272155923;9642.951785241028;9939.155171810333;10458.63394781179;12691.492340306284;12723.04577156717;12747.42636581356;12756.170848894792;12785.808212876815;6847.486438517131;7163.641817909083;7253.202147763847;7293.088363954505;7467.626618669045;6926.792196234121;6958.7912362628185;7139.92860071403;7194.820129496805;7224.566526008456;4082.8775136745944;4169.124483858423;4215.515215750167;4306.246406878784;4333.263345231318;1722.46603552899;1754.1492376197534;1761.4803632928317;1769.3541857222021;1772.1936518883876;811.7605306434616;826.710651272062;843.5950743643085;854.3421565394735;876.2245412809582;17657.38199163023;18098.27606895736;18107.18517666708;18391.02291755185;18527.351542695942;811.6428771340592;830.4892491117919;862.9180227878342;865.0354854337369;867.085225087526;9538.475383853816;10210.453226233496;10225.386476811414;10325.63860264887;10425.374477531372;392674;404991;407021;408159;408355;45978.54021459743;67452.662736686;78894;80048;80279;855.8758979947997;883.7481317824518;888.7378223424106;892.2727976698969;895.2524641924066;15990.360385584912;16981.320747169975;17305.13474326304;17324.133793310033;17434.825651743322;38800.6119938797;40519;40869.59130408658;40919.795401022806;41588.16823663449;55254.72372638111;56858.7157064212;57064;57085.71457142688;57671;7459.962700186465;7652.923470765221;7679.540887231408;7810.3751699865015;8088.514689118671;10350.948245258725;12467.812982805084;12637.684057898627;12676.23942563449;12747.298898560668;9867.901320986699;10174.796504070026;10215.13171380441;10265.281430299807;10386.376817390981;10595.523201455799;10692.518836652214;10748.785024299626;10888.128949683847;11166.218364714392;10298.536565854705;10486.52810623539;10672.092872105648;10697.083655019425;10912.181586380895;7556.65995030214;7624.771256862303;7720.884186737316;7909.564973926489;8154.469959452854;9188.127127922837;9636;9641.807163856824;10501.579936802442;10969.945150274198 03:44:31 INFO - PROCESS | 12862 | |3;mootools.html;1234.3643023842717;1340.544214966911;1392.6796836727553;1453.316941037712;1675.622984828413;6416.294207637162;7253.383462405695;7603.0496187976505;7604.3916486681;7803;7574.583397913113;7647.120581133171;7648.961755191216;7659.463837531375;7663.463557550974;2162.7296587926508;2187.07049503961;2188.0919418441326;2188.6607575825774;2189.179057853305;2129.552793913272;2166.7074944882397;2224.177054489841;2226;2227.265002549155;2162.297253392646;2174.2172817785586;2180.31320134158;2180.8364372672036;2210.171185805323;2155.9568808623817;2158.104386679526;2159.3090211132444;2162.0270878104757;2162.0703097668074;2074.844386670991;2127.478767701923;2132.7120838686733;2134.882581458019;2136.102836808544;7492.887606685904;7620.276073772982;7662;7722.3049925506975;7724.6137693115115;4172.436721042651;4332.371806088131;4344.565543445662;4346.847860324873;4349.13017396522;2589.3526618345413;2732.8770205340807;2758.8620568971673;2768.1280396675184;2770.362816552184;846.6697987784769;863.5380071661693;866.2420382165606;874.868769684546;891.064382398479;10075.546600402926;10213.33613315132;10235.283530152967;10236.948815255875;10241.12950399217;3702.500162478085;3912.902177445587;4006.779627120478;4007.599240075969;4014.197160567898;8149.103598604149;8149.7147599833725;8155.959220203979;8161.510309381456;8172.346212303001;4328.956710432918;4336.804843782037;4340.153670034313;4344.782760861945;4350.782460876943;3485.6514348564942;3624.1120925373452;3864.7101467390057;4023.6177563131455;4028.0131367815075;3324.7173990211104;3326.9500957485657;3470.878519251814;3474.739394545419;3493.8951831445097;1024.948752562369;1032.9173666106844;1046.8796088449926;1053.3627155570923;1066.1630619963446;654.6922946215271;711.3562226185311;799.5482552358015;829.7593697827563;840.0213750980162;5009.323741294878;5075.137226671474;5102.08162530748;5187.144121220032;5228.2680424740565;380.2490082087854;385.4719034922119;386.08112691793355;386.26802209812246;391.12973633665433;3455.4298540740997;3470.6182319944787;3540.168060505779;3596.6762991330907;3669.9266014679556;9175.908240917639;9558.091981261769;9614.375065620712;9653.1794797443;9666.565004574812;9591.808163836684;9596.23230141587;9600.903990960142;9601.703769991102;9608.519574021411;7179.138503379523;7277.126744790659;7329.706811727471;7349.853002939912;7354.448416368794;5231.712255825966;5289.338832645919;5293.973530132479;5297.337832770903;5307.416184219655;8554.615042323236;8635.222829945335;8734.344924130843;8770.035296117294;8798.692045778367;8890.777730556787;8922.643094276156;8935.955320223356;8976.41653292534;8982;5433.646812957145;5846.123081537633;6279.434850863444;6336.873262534631;6343.746250149942;6976.267491913276;7359.632018398952;7361.631918403951;7380.114386273682;7391.852162956603;6598.90101648466;6615.636140012345;6631.867362652816;6736.157980252468;6818.897716534157;6556.475481961527;6563.212414510289;6581.638009909309;6608.7356505739235;6611.966940165268;6053.273607167168;6133.53998450127;6140.754369825157;6140.907886381798;6141.785037523665;4495.2358099122575;4547.067851090453;4607.907841843212;4653.348531205702;4676.55572720591;4389.692721509591;4477.104579084261;4509.616682582017;4575.450945886515;4697.13103075932 03:44:31 INFO - PROCESS | 12862 | |4;prototype.html;285.4448098448518;285.61442053228143;290.20628580831425;291.4898926877962;292.8155262184826;4895.21676531755;4905.950940490594;4927.6550641455115;4927.950720492794;4937.777799998999;4792.257200133976;4802.83190088347;4840.225563909775;4846.733429661367;4862.878428039301;3574.2672752085823;3679.411294192916;3712.4407748745457;3760.5111335526344;3796.126890815114;3720.7767533947913;3777.7911068458106;3786.3752480840767;3799.9430008549894;3814.5803961564206;3727.3477141500266;3732.346839303125;3739.738218324718;3741.681957033642;3767.284215998965;3609.9458508122398;3649.59854416014;3740.139767853409;3758.586555478895;3763.9811800941093;3299.934001319984;3307.8918562281665;3313.5858017747782;3322.1362445764034;3329.6836800503916;4747.169245382044;4767.690100143514;4768.380110585602;4772.689775164603;4785.994941062381;4188.62302392783;4337.262665346867;4337.696361254713;4340.696151269412;4361.149575832714;5022.924656130161;5052.393712754456;5055.620828437882;5057.5448209660935;5067.5185857343495;3639.9818000909827;3640.9271814563826;3643;3645.2891686121216;3655.3603119454256;5120.539151476422;5285.973570132163;5344.652597581184;5349.4650534946195;5354.437784032699;3668.944965825515;3683.171286460525;3693.778373297611;3694.8706795262574;3697.5193224880595;3742.2515496900182;3743.21392507571;3744.700423966076;3749.7937613430977;3758.229562939591;4309.159713855768;4310.44823863409;4312.110885706584;4320.287152619845;4331.480222373335;4905.166121759309;4983.103041452501;5010.849674509771;5103.515166059218;5112.8466146014935;1265.5380786013038;1288.3171918883006;1290.1356091418772;1291.9418626161657;1294.1911305434103;800.7917941335295;820.9655833649645;833.9916600834035;841.9747407577782;842.6797816829566;4302.82788688449;4403.207422663952;4411.360352748898;4438.911221775546;4459.576340247671;5165.638405311667;5172.482751724798;5174.275601415805;5188.481151884781;5228.55557277628;4418.734875907456;4426.269665505156;4440.755758433253;4440.955590444054;4485.708428952108;2617.2148355493277;2754.724527547269;2758.641376621026;2760.903368382137;2771.4041481081663;4930.2358134488495;4945.184044632667;4953.6532442729385;4954.083494553519;4970.17992031318;5260.500252476008;5280.1815718563685;5404.432534583891;5434.592405569598;5442.537384322377;4881.829135980294;4900.779464924087;4903.730294833747;4911.45973942866;4918.655694101379;5213.462028701618;5216.295800066942;5238.659487133325;5247.763850626808;5257.684538927677;4850.320955066223;5112.261830977485;5141.53726164647;5174.404943431403;5192.221166824856;4947.431045429677;4958.776855041459;4964.280179374043;4976.208564916699;5000.64995450315;3678.2459595782266;3682.6317368262958;3690.7820419262116;3702.3705969985704;3704.740668153311;5074.213496907985;5266.631335806457;5344.225087362389;5352.625316227826;5360.195970604441;5041.168207245763;5041.42023667283;5049.368828896388;5050.545450909436;5059.418166910705;5058.367704036996;5062.594992400673;5065.214891691794;5077.213031980049;5095.261187127771;4702.202189697125;4950.158473059517;5002.974390249918;5005.274235235943;5032.3961124665275;4853.126437241331;4924.236743304794;5059.519345662156;5070.264811602223;5086.618503612318;4973.303737476828;4977.278294647183;4978.286833675728;5010.949890501049;5031.597472202288 03:44:31 INFO - PROCESS | 12862 | |5;yui.html;601.3925934805847;635.6916895305776;641.2305233719537;662.5991275278457;743.2456057102039;12129.272243665375;12682.936585317071;12978.221306721603;13029.674258143552;13152.210867347954;13104.14823036502;13256.93371533141;13259.602211933658;13271.071025028252;13280.402381892814;624.9843753906143;769.8691222492175;790.2137373313561;791.6793698552067;792.8335049639554;750.898628685126;786.2884089898622;788.3377962511489;788.6332855222321;792.5165648954134;834.4409245805294;835.6699103853974;836.7155167243136;836.8953880764905;837.4054421360842;656.4289068510426;825.8018075661857;828.9129641387627;829.3986859526855;829.5396055189367;579.9304083509963;599.053495477145;601.7562887030759;601.9187409699722;602.4908951935652;12813.231206127663;12826;12828.422720977578;12835.165714228639;12850.228986260854;11572.479238434207;11989.520419183222;12164.635060948098;12331.260124392566;13024.088313818036;11254.26847254934;11302.152338574557;11315.434228288635;11495.88504114965;11797.115216358721;3997.84008639657;4012.4382586437923;4046.1300820323772;4090.2228576570656;4105.158442519277;53151.73424132893;55230.72384638091;55347.44652553504;68571.65714171447;69402.30597694009;10319.896801032044;10439.321444106108;10509.894901050891;10751.569937202425;10888.128949684005;18904.054797260083;18914;19021.714674279898;19110.904445477685;19127.2349106037;6976.51164418496;7048.224695283515;7168.4265258780215;7251.021112149898;7398.223186565441;3961.9405708914387;4019.055521952339;4032.475778148822;4034.919301613951;4065.8576949807207;2774.8057635965692;2839.034728192383;2857.3856620826623;2862.069827306134;2870.167651381118;506.1168261383835;507.84256880367207;508.64903216780306;513.8073222541547;515.0985774893935;564.2354609504063;618.517556306073;621.7388696747377;630.8864404407159;633.6134957675814;7773.68905243784;7831.960840195877;8249.958750206331;8339.499630022097;8466.830663386821;531.1236459841216;574.8160588611688;615.7352338494491;618.7710547097513;635.4566845347254;3755.211405604799;3796.4115562087923;3801.5248093988253;3811.2187001664593;4043.9191216175514;104010;104014.8394064244;104486;105972.47013765037;106170.46914765377;87917;88400.5579972096;91130;94972.52513737387;95038.52480737552;69396.30603693899;76533;76712.23287767051;79637;81196.59401702836;6994.3355381240735;7153.1416230050645;7242.637868106468;7253.238409966877;7284.417246620364;44745.328820068375;44913.550864490935;45061.549384507045;46535.301970469794;48362.5163748358;40535.391969121076;41292;47794;53747.73126134344;56259;10798.190135740007;10802.297850639683;11105.777884442428;11122.499487522919;11306.660800176009;12099;12123.878761212274;12382.62852114438;13260.602181934557;13323.13399629021;11449.427528623703;11849.289042657469;11958.64124076279;12218.389080546114;12225.266484010988;11934.224275422417;12082.577109801116;12265.448054837376;12294.81557776652;12859.29273889945;11153.163512736415;11583.189176757545;11639.5344186235;11660.591879284184;11915.821262680893;9953.950230248802;10046.497675116361;10050.775026430014;10143.84784228252;10454.477276136315;9231.630734770803;10177.134943529883;10423;10479.790404192026;10495.317804342692 03:44:31 INFO - PROCESS | 12862 | __end_tp_report 03:44:31 INFO - PROCESS | 12862 | __start_cc_report 03:44:31 INFO - PROCESS | 12862 | _x_x_mozilla_cycle_collect,947 03:44:31 INFO - PROCESS | 12862 | __end_cc_report 03:44:31 INFO - PROCESS | 12862 | __startTimestamp1470307471594__endTimestamp 03:44:31 INFO - PROCESS | 12862 | 03:44:31 INFO - PROCESS | 12862 | ------- Summary: start ------- 03:44:31 INFO - PROCESS | 12862 | Number of tests: 6 03:44:31 INFO - PROCESS | 12862 | 03:44:31 INFO - PROCESS | 12862 | [#0] dojo.html Cycles:165 Average:4817.70 Median:4943.85 stddev:518.63 (10.5%) stddev-sans-first:490.45 03:44:31 INFO - PROCESS | 12862 | Values: 2609.8 2655.9 2659.8 2684.3 2719.7 4671.1 4726.7 4802.2 4957.1 4974.4 4809.9 4851.6 4866.1 4895.1 4900.3 4370.5 4428.2 4468.7 4525.7 4609.8 4530.6 4563.0 4574.6 4593.5 4594.8 4326.0 4366.6 4367.5 4429.3 4468.7 4411.2 4438.8 4448.9 4535.5 4541.6 4459.2 4468.1 4482.3 4511.3 4512.1 4716.3 4904.0 4907.8 4958.0 4958.3 5166.9 5210.9 5222.2 5283.9 5295.2 5244.5 5259.5 5304.2 5314.8 5325.2 4749.4 4903.6 4926.8 4939.4 4943.9 5282.2 5314.9 5345.8 5452.2 5453.5 5169.8 5183.4 5228.2 5231.5 5236.8 5034.1 5311.5 5320.6 5321.7 5330.1 5106.6 5168.0 5178.9 5267.5 5273.1 5201.8 5204.9 5205.6 5212.1 5254.7 4478.5 4479.8 4480.2 4511.5 4528.7 3832.8 3847.5 3847.7 3882.4 3885.3 4438.2 4449.7 4472.1 4481.9 4496.2 5223.5 5253.7 5258.7 5267.1 5267.8 4296.7 4368.7 4406.7 4454.5 4490.0 4708.1 4724.9 4730.4 4754.0 4780.8 4892.8 4896.5 4897.7 4899.7 4936.6 4946.9 5169.0 5191.6 5258.5 5290.3 4889.5 4902.1 4907.1 4936.6 4953.9 5163.3 5176.9 5178.1 5180.7 5228.0 4992.1 5118.4 5118.6 5242.1 5253.8 5036.5 5039.3 5041.9 5077.6 5094.4 5022.6 5037.9 5039.4 5060.5 5085.7 4811.0 4874.6 4944.9 4978.6 5032.1 5078.7 5084.5 5093.5 5117.0 5130.2 4935.7 4969.6 4971.7 4976.8 5031.8 03:44:31 INFO - PROCESS | 12862 | 03:44:31 INFO - PROCESS | 12862 | [#1] ext.html Cycles:180 Average:47415.59 Median:199748.91 stddev:82813.78 (41.5%) stddev-sans-first:82971.37 03:44:31 INFO - PROCESS | 12862 | Values: 560.2 565.8 569.2 580.2 585.1 29862.3 40507.6 42008.2 42012.2 45659.5 41973.4 42314.0 42576.1 42606.6 42622.6 7687.5 7797.3 7825.6 7829.1 7829.6 7467.8 9503.8 9725.1 9735.0 10003.5 9971.6 10024.8 10046.8 10048.6 10051.7 9859.2 9864.8 9906.8 9934.4 9938.0 9823.6 9877.8 9884.0 9887.1 9896.1 38430.2 38605.8 38794.4 38827.6 38840.4 3099.7 3105.9 3204.7 3232.0 3333.0 29817.3 30143.0 30411.2 30503.1 30625.7 3229.1 3281.2 3295.1 3304.8 3307.6 238560.0 241939.0 243122.0 243341.0 244399.0 54658.0 55034.0 55133.0 55174.0 55232.7 57875.7 57935.0 58156.7 58248.0 58334.4 14778.3 15065.6 15071.2 15082.8 15083.3 9231.2 9715.0 9746.6 9820.5 10594.5 16242.9 16925.8 17032.7 17048.6 17247.0 5508.1 5510.3 5521.9 5552.9 5680.7 803.0 878.5 888.8 919.7 921.0 28215.6 28335.1 28423.9 28746.1 28815.9 996.3 999.5 1009.5 1012.6 1033.0 15029.5 15288.8 15390.6 15594.5 15739.8 363354.0 375799.0 376249.0 376769.0 377614.0 48654.3 48938.8 48989.8 49002.3 49035.5 1098.8 1178.9 1184.5 1205.4 1208.3 26853.2 29138.7 29313.3 29677.0 29908.9 42573.0 43313.0 43479.8 43569.6 43688.8 312404.0 316012.0 317216.0 317496.0 317581.0 32288.5 33356.0 36830.0 37140.0 37632.8 38393.2 41350.0 41654.0 41986.0 42497.4 34191.3 34909.1 35534.0 35562.6 35628.8 35747.8 35854.0 35907.6 36143.8 36348.8 34732.5 35015.8 35158.1 35256.5 35869.8 30280.0 32657.8 32818.0 32852.0 33009.2 24692.8 25225.4 25253.5 25516.4 25548.2 03:44:31 INFO - PROCESS | 12862 | 03:44:31 INFO - PROCESS | 12862 | [#2] jquery.html Cycles:180 Average:24616.84 Median:4192.32 stddev:66652.24 (1589.9%) stddev-sans-first:66814.30 03:44:31 INFO - PROCESS | 12862 | Values: 339.9 346.4 351.0 355.8 371.3 13018.9 16461.1 16472.1 17106.9 18094.6 16429.8 16711.5 16925.2 16961.7 16994.2 4926.4 4926.9 5092.9 5106.3 5110.3 3681.5 4792.9 5053.3 5551.2 5850.8 5860.7 5877.0 5893.4 5904.6 5907.6 5082.2 5279.9 5294.2 5428.1 5901.0 5259.3 5263.1 5275.0 5275.4 5279.9 11659.1 11696.9 11860.1 11900.7 12021.6 1905.7 1961.2 1978.4 1986.0 2049.8 8660.1 9449.7 9676.0 11753.8 12935.4 1719.0 1738.6 1766.1 1789.9 1822.8 65428.7 66563.0 68537.7 68701.3 71003.3 9536.3 9581.9 9643.0 9939.2 10458.6 12691.5 12723.0 12747.4 12756.2 12785.8 6847.5 7163.6 7253.2 7293.1 7467.6 6926.8 6958.8 7139.9 7194.8 7224.6 4082.9 4169.1 4215.5 4306.2 4333.3 1722.5 1754.1 1761.5 1769.4 1772.2 811.8 826.7 843.6 854.3 876.2 17657.4 18098.3 18107.2 18391.0 18527.4 811.6 830.5 862.9 865.0 867.1 9538.5 10210.5 10225.4 10325.6 10425.4 392674.0 404991.0 407021.0 408159.0 408355.0 45978.5 67452.7 78894.0 80048.0 80279.0 855.9 883.7 888.7 892.3 895.3 15990.4 16981.3 17305.1 17324.1 17434.8 38800.6 40519.0 40869.6 40919.8 41588.2 55254.7 56858.7 57064.0 57085.7 57671.0 7460.0 7652.9 7679.5 7810.4 8088.5 10350.9 12467.8 12637.7 12676.2 12747.3 9867.9 10174.8 10215.1 10265.3 10386.4 10595.5 10692.5 10748.8 10888.1 11166.2 10298.5 10486.5 10672.1 10697.1 10912.2 7556.7 7624.8 7720.9 7909.6 8154.5 9188.1 9636.0 9641.8 10501.6 10969.9 03:44:31 INFO - PROCESS | 12862 | 03:44:31 INFO - PROCESS | 12862 | [#3] mootools.html Cycles:180 Average:4964.04 Median:5042.23 stddev:2820.27 (55.9%) stddev-sans-first:2814.26 03:44:31 INFO - PROCESS | 12862 | Values: 1234.4 1340.5 1392.7 1453.3 1675.6 6416.3 7253.4 7603.0 7604.4 7803.0 7574.6 7647.1 7649.0 7659.5 7663.5 2162.7 2187.1 2188.1 2188.7 2189.2 2129.6 2166.7 2224.2 2226.0 2227.3 2162.3 2174.2 2180.3 2180.8 2210.2 2156.0 2158.1 2159.3 2162.0 2162.1 2074.8 2127.5 2132.7 2134.9 2136.1 7492.9 7620.3 7662.0 7722.3 7724.6 4172.4 4332.4 4344.6 4346.8 4349.1 2589.4 2732.9 2758.9 2768.1 2770.4 846.7 863.5 866.2 874.9 891.1 10075.5 10213.3 10235.3 10236.9 10241.1 3702.5 3912.9 4006.8 4007.6 4014.2 8149.1 8149.7 8156.0 8161.5 8172.3 4329.0 4336.8 4340.2 4344.8 4350.8 3485.7 3624.1 3864.7 4023.6 4028.0 3324.7 3327.0 3470.9 3474.7 3493.9 1024.9 1032.9 1046.9 1053.4 1066.2 654.7 711.4 799.5 829.8 840.0 5009.3 5075.1 5102.1 5187.1 5228.3 380.2 385.5 386.1 386.3 391.1 3455.4 3470.6 3540.2 3596.7 3669.9 9175.9 9558.1 9614.4 9653.2 9666.6 9591.8 9596.2 9600.9 9601.7 9608.5 7179.1 7277.1 7329.7 7349.9 7354.4 5231.7 5289.3 5294.0 5297.3 5307.4 8554.6 8635.2 8734.3 8770.0 8798.7 8890.8 8922.6 8936.0 8976.4 8982.0 5433.6 5846.1 6279.4 6336.9 6343.7 6976.3 7359.6 7361.6 7380.1 7391.9 6598.9 6615.6 6631.9 6736.2 6818.9 6556.5 6563.2 6581.6 6608.7 6612.0 6053.3 6133.5 6140.8 6140.9 6141.8 4495.2 4547.1 4607.9 4653.3 4676.6 4389.7 4477.1 4509.6 4575.5 4697.1 03:44:31 INFO - PROCESS | 12862 | 03:44:31 INFO - PROCESS | 12862 | [#4] prototype.html Cycles:180 Average:4209.56 Median:4851.72 stddev:1232.25 (25.4%) stddev-sans-first:1199.99 03:44:31 INFO - PROCESS | 12862 | Values: 285.4 285.6 290.2 291.5 292.8 4895.2 4906.0 4927.7 4928.0 4937.8 4792.3 4802.8 4840.2 4846.7 4862.9 3574.3 3679.4 3712.4 3760.5 3796.1 3720.8 3777.8 3786.4 3799.9 3814.6 3727.3 3732.3 3739.7 3741.7 3767.3 3609.9 3649.6 3740.1 3758.6 3764.0 3299.9 3307.9 3313.6 3322.1 3329.7 4747.2 4767.7 4768.4 4772.7 4786.0 4188.6 4337.3 4337.7 4340.7 4361.1 5022.9 5052.4 5055.6 5057.5 5067.5 3640.0 3640.9 3643.0 3645.3 3655.4 5120.5 5286.0 5344.7 5349.5 5354.4 3668.9 3683.2 3693.8 3694.9 3697.5 3742.3 3743.2 3744.7 3749.8 3758.2 4309.2 4310.4 4312.1 4320.3 4331.5 4905.2 4983.1 5010.8 5103.5 5112.8 1265.5 1288.3 1290.1 1291.9 1294.2 800.8 821.0 834.0 842.0 842.7 4302.8 4403.2 4411.4 4438.9 4459.6 5165.6 5172.5 5174.3 5188.5 5228.6 4418.7 4426.3 4440.8 4441.0 4485.7 2617.2 2754.7 2758.6 2760.9 2771.4 4930.2 4945.2 4953.7 4954.1 4970.2 5260.5 5280.2 5404.4 5434.6 5442.5 4881.8 4900.8 4903.7 4911.5 4918.7 5213.5 5216.3 5238.7 5247.8 5257.7 4850.3 5112.3 5141.5 5174.4 5192.2 4947.4 4958.8 4964.3 4976.2 5000.6 3678.2 3682.6 3690.8 3702.4 3704.7 5074.2 5266.6 5344.2 5352.6 5360.2 5041.2 5041.4 5049.4 5050.5 5059.4 5058.4 5062.6 5065.2 5077.2 5095.3 4702.2 4950.2 5003.0 5005.3 5032.4 4853.1 4924.2 5059.5 5070.3 5086.6 4973.3 4977.3 4978.3 5010.9 5031.6 03:44:31 INFO - PROCESS | 12862 | 03:44:31 INFO - PROCESS | 12862 | [#5] yui.html Cycles:180 Average:17849.13 Median:22300.62 stddev:26086.89 (117.0%) stddev-sans-first:26127.93 03:44:31 INFO - PROCESS | 12862 | Values: 601.4 635.7 641.2 662.6 743.2 12129.3 12682.9 12978.2 13029.7 13152.2 13104.1 13256.9 13259.6 13271.1 13280.4 625.0 769.9 790.2 791.7 792.8 750.9 786.3 788.3 788.6 792.5 834.4 835.7 836.7 836.9 837.4 656.4 825.8 828.9 829.4 829.5 579.9 599.1 601.8 601.9 602.5 12813.2 12826.0 12828.4 12835.2 12850.2 11572.5 11989.5 12164.6 12331.3 13024.1 11254.3 11302.2 11315.4 11495.9 11797.1 3997.8 4012.4 4046.1 4090.2 4105.2 53151.7 55230.7 55347.4 68571.7 69402.3 10319.9 10439.3 10509.9 10751.6 10888.1 18904.1 18914.0 19021.7 19110.9 19127.2 6976.5 7048.2 7168.4 7251.0 7398.2 3961.9 4019.1 4032.5 4034.9 4065.9 2774.8 2839.0 2857.4 2862.1 2870.2 506.1 507.8 508.6 513.8 515.1 564.2 618.5 621.7 630.9 633.6 7773.7 7832.0 8250.0 8339.5 8466.8 531.1 574.8 615.7 618.8 635.5 3755.2 3796.4 3801.5 3811.2 4043.9 104010.0 104014.8 104486.0 105972.5 106170.5 87917.0 88400.6 91130.0 94972.5 95038.5 69396.3 76533.0 76712.2 79637.0 81196.6 6994.3 7153.1 7242.6 7253.2 7284.4 44745.3 44913.6 45061.5 46535.3 48362.5 40535.4 41292.0 47794.0 53747.7 56259.0 10798.2 10802.3 11105.8 11122.5 11306.7 12099.0 12123.9 12382.6 13260.6 13323.1 11449.4 11849.3 11958.6 12218.4 12225.3 11934.2 12082.6 12265.4 12294.8 12859.3 11153.2 11583.2 11639.5 11660.6 11915.8 9954.0 10046.5 10050.8 10143.8 10454.5 9231.6 10177.1 10423.0 10479.8 10495.3 03:44:31 INFO - PROCESS | 12862 | -------- Summary: end -------- 03:44:31 INFO - PROCESS | 12862 | 03:44:32 INFO - TEST-INFO | 12862: exit 0 03:44:32 INFO - TEST-OK | dromaeo_css | took 1120324ms 03:44:32 INFO - TEST-START | kraken 03:44:32 INFO - operating with platform_type : linux_ 03:44:32 INFO - Initialising browser for kraken test... 03:44:32 INFO - TEST-INFO | started process 13047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzMWhav/profile http://localhost:54950/getInfo.html) 03:44:36 INFO - PROCESS | 13047 | __metrics Screen width/height:1600/1200 03:44:36 INFO - PROCESS | 13047 | colorDepth:24 03:44:36 INFO - PROCESS | 13047 | Browser inner width/height: 1024/697 03:44:36 INFO - PROCESS | 13047 | __metrics 03:44:37 INFO - PROCESS | 13047 | 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:44:37 INFO - PROCESS | 13047 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:44:38 INFO - TEST-INFO | 13047: exit 0 03:44:38 INFO - Browser initialized. 03:44:38 INFO - Running cycle 1/1 for kraken test... 03:44:38 INFO - TEST-INFO | started process 13128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzMWhav/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:50 INFO - PROCESS | 13128 | RSS: Main: 157999104 03:44:50 INFO - PROCESS | 13128 | 03:44:53 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54950/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:54 INFO - PROCESS | 13128 | RSS: Main: 214335488 03:44:54 INFO - PROCESS | 13128 | 03:44:56 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54950/tests/kraken/driver.html?testName=audio-dft) 03:44:57 INFO - PROCESS | 13128 | RSS: Main: 192802816 03:44:57 INFO - PROCESS | 13128 | 03:45:00 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54950/tests/kraken/driver.html?testName=audio-fft) 03:45:01 INFO - PROCESS | 13128 | RSS: Main: 271724544 03:45:01 INFO - PROCESS | 13128 | 03:45:03 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54950/tests/kraken/driver.html?testName=audio-oscillator) 03:45:04 INFO - PROCESS | 13128 | RSS: Main: 180953088 03:45:04 INFO - PROCESS | 13128 | 03:45:06 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54950/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:07 INFO - PROCESS | 13128 | RSS: Main: 185040896 03:45:07 INFO - PROCESS | 13128 | 03:45:10 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54950/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:10 INFO - PROCESS | 13128 | RSS: Main: 221548544 03:45:10 INFO - PROCESS | 13128 | 03:45:14 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54950/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:15 INFO - PROCESS | 13128 | RSS: Main: 215494656 03:45:15 INFO - PROCESS | 13128 | 03:45:17 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54950/tests/kraken/driver.html?testName=json-parse-financial) 03:45:18 INFO - PROCESS | 13128 | RSS: Main: 218812416 03:45:18 INFO - PROCESS | 13128 | 03:45:20 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54950/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:20 INFO - PROCESS | 13128 | RSS: Main: 184336384 03:45:20 INFO - PROCESS | 13128 | 03:45:22 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54950/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:23 INFO - PROCESS | 13128 | RSS: Main: 190099456 03:45:23 INFO - PROCESS | 13128 | 03:45:25 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54950/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:26 INFO - PROCESS | 13128 | RSS: Main: 194453504 03:45:26 INFO - PROCESS | 13128 | 03:45:28 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:29 INFO - PROCESS | 13128 | RSS: Main: 189865984 03:45:29 INFO - PROCESS | 13128 | 03:45:32 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:33 INFO - PROCESS | 13128 | RSS: Main: 192995328 03:45:33 INFO - PROCESS | 13128 | 03:45:34 INFO - PROCESS | 13128 | Cycle 1(1): loaded http://localhost:54950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54950/tests/kraken/driver.html?testName=ai-astar) 03:45:35 INFO - PROCESS | 13128 | RSS: Main: 243175424 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | __start_tp_report 03:45:35 INFO - PROCESS | 13128 | _x_x_mozilla_page_load 03:45:35 INFO - PROCESS | 13128 | _x_x_mozilla_page_load_details 03:45:35 INFO - PROCESS | 13128 | |i|pagename|runs| 03:45:35 INFO - PROCESS | 13128 | |0;ai-astar;106;118;115;117;117;116;116;115;115;114 03:45:35 INFO - PROCESS | 13128 | |1;audio-beat-detection;158;129;124;193;125;125;145;129;167;123 03:45:35 INFO - PROCESS | 13128 | |2;audio-dft;161;162;161;160;161;160;161;162;162;163 03:45:35 INFO - PROCESS | 13128 | |3;audio-fft;75;75;76;134;75;76;74;75;101;75 03:45:35 INFO - PROCESS | 13128 | |4;audio-oscillator;85;86;125;85;87;85;118;85;87;134 03:45:35 INFO - PROCESS | 13128 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;117;117;116 03:45:35 INFO - PROCESS | 13128 | |6;imaging-darkroom;147;147;147;146;147;148;147;147;146;146 03:45:35 INFO - PROCESS | 13128 | |7;imaging-desaturate;94;96;95;96;96;95;96;96;95;95 03:45:35 INFO - PROCESS | 13128 | |8;json-parse-financial;64;64;63;63;62;63;63;62;62;63 03:45:35 INFO - PROCESS | 13128 | |9;json-stringify-tinderbox;65;65;65;65;64;65;65;65;64;65 03:45:35 INFO - PROCESS | 13128 | |10;stanford-crypto-aes;80;79;79;79;79;79;79;79;79;78 03:45:35 INFO - PROCESS | 13128 | |11;stanford-crypto-ccm;132;132;129;131;127;130;129;128;189;141 03:45:35 INFO - PROCESS | 13128 | |12;stanford-crypto-pbkdf2;169;169;167;169;170;168;166;164;172;166 03:45:35 INFO - PROCESS | 13128 | |13;stanford-crypto-sha256-iterative;67;67;66;67;69;68;68;66;66;67 03:45:35 INFO - PROCESS | 13128 | __end_tp_report 03:45:35 INFO - PROCESS | 13128 | __start_cc_report 03:45:35 INFO - PROCESS | 13128 | _x_x_mozilla_cycle_collect,1984 03:45:35 INFO - PROCESS | 13128 | __end_cc_report 03:45:35 INFO - PROCESS | 13128 | __startTimestamp1470307535042__endTimestamp 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | ------- Summary: start ------- 03:45:35 INFO - PROCESS | 13128 | Number of tests: 14 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:3.35 (2.9%) stddev-sans-first:1.27 03:45:35 INFO - PROCESS | 13128 | Values: 106.0 118.0 115.0 117.0 117.0 116.0 116.0 115.0 115.0 114.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:137.00 stddev:23.79 (17.4%) stddev-sans-first:24.49 03:45:35 INFO - PROCESS | 13128 | Values: 158.0 129.0 124.0 193.0 125.0 125.0 145.0 129.0 167.0 123.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 03:45:35 INFO - PROCESS | 13128 | Values: 161.0 162.0 161.0 160.0 161.0 160.0 161.0 162.0 162.0 163.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:19.49 (26.0%) stddev-sans-first:20.43 03:45:35 INFO - PROCESS | 13128 | Values: 75.0 75.0 76.0 134.0 75.0 76.0 74.0 75.0 101.0 75.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:85.00 stddev:19.68 (23.2%) stddev-sans-first:20.33 03:45:35 INFO - PROCESS | 13128 | Values: 85.0 86.0 125.0 85.0 87.0 85.0 118.0 85.0 87.0 134.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:45:35 INFO - PROCESS | 13128 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:45:35 INFO - PROCESS | 13128 | Values: 147.0 147.0 147.0 146.0 147.0 148.0 147.0 147.0 146.0 146.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 03:45:35 INFO - PROCESS | 13128 | Values: 94.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 03:45:35 INFO - PROCESS | 13128 | Values: 64.0 64.0 63.0 63.0 62.0 63.0 63.0 62.0 62.0 63.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 03:45:35 INFO - PROCESS | 13128 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 65.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:0.47 (0.6%) stddev-sans-first:0.33 03:45:35 INFO - PROCESS | 13128 | Values: 80.0 79.0 79.0 79.0 79.0 79.0 79.0 79.0 79.0 78.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:131.50 stddev:18.75 (14.3%) stddev-sans-first:19.81 03:45:35 INFO - PROCESS | 13128 | Values: 132.0 132.0 129.0 131.0 127.0 130.0 129.0 128.0 189.0 141.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:169.00 stddev:2.31 (1.4%) stddev-sans-first:2.42 03:45:35 INFO - PROCESS | 13128 | Values: 169.0 169.0 167.0 169.0 170.0 168.0 166.0 164.0 172.0 166.0 03:45:35 INFO - PROCESS | 13128 | 03:45:35 INFO - PROCESS | 13128 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 03:45:35 INFO - PROCESS | 13128 | Values: 67.0 67.0 66.0 67.0 69.0 68.0 68.0 66.0 66.0 67.0 03:45:35 INFO - PROCESS | 13128 | -------- Summary: end -------- 03:45:35 INFO - PROCESS | 13128 | 03:45:36 INFO - TEST-INFO | 13128: exit 0 03:45:36 INFO - TEST-OK | kraken | took 63719ms 03:45:36 INFO - SUITE-END | took 1184s 03:45:36 INFO - Completed test suite (00:19:44) 03:45:36 INFO - javascript benchmark 03:45:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.765121139097, 2655.8539280339587, 2659.8138130330885, 2684.342336127649, 2719.72802719728, 4671.112488627167, 4726.716397016182, 4802.207635740103, 4957.082939656166, 4974.4030716314, 4809.855704328876, 4851.587615052725, 4866.051120031595, 4895.069936712022, 4900.313956046157, 4370.5410931852175, 4428.1807865544815, 4468.664850136252, 4525.683202175849, 4609.815607375717, 4530.637548996089, 4562.954370456286, 4574.565416285448, 4593.5406459354135, 4594.816207351702, 4326.0, 4366.607005369532, 4367.45406824147, 4429.313456414261, 4468.731876087445, 4411.183930972748, 4438.800253988578, 4448.888777780581, 4535.546445355471, 4541.636669066466, 4459.197344477992, 4468.084042771224, 4482.327650852366, 4511.345854851061, 4512.097580483916, 4716.316134160562, 4904.0437114762635, 4907.779149938261, 4958.00839832035, 4958.2562615607585, 5166.896662066775, 5210.947890521084, 5222.242774797671, 5283.867903302448, 5295.179247216649, 5244.475552444763, 5259.500347467023, 5304.177852432879, 5314.813981510629, 5325.227841962894, 4749.35883655702, 4903.5586797188425, 4926.778294976734, 4939.407271127488, 4943.8516844494725, 5282.234076059027, 5314.867128321823, 5345.786168553214, 5452.154915988028, 5453.454654534594, 5169.844904652867, 5183.352080989876, 5228.189630607186, 5231.529162375405, 5236.816711415082, 5034.0686972910125, 5311.468853114658, 5320.574354051667, 5321.73391330432, 5330.067238233371, 5106.642535022513, 5168.043911876315, 5178.870528236749, 5267.473252674778, 5273.1035723927025, 5201.7919283229, 5204.8959020819375, 5205.609579281493, 5212.139996900545, 5254.710990895537, 4478.484974228006, 4479.776011199427, 4480.193565158303, 4511.503734589192, 4528.705634133771, 3832.80835958201, 3847.480590120354, 3847.74989625679, 3882.417637354363, 3885.3006458837117, 4438.245498265303, 4449.688521803443, 4472.105578884236, 4481.910361792811, 4496.19068567661, 5223.5037671421915, 5253.684778913277, 5258.710770907637, 5267.051930652443, 5267.762950667229, 4296.656267498593, 4368.716033457815, 4406.713563618418, 4454.532274111237, 4490.034642551867, 4708.128996135726, 4724.929126063112, 4730.408698912636, 4753.9762301188275, 4780.808767649255, 4892.804287828447, 4896.485868983706, 4897.706137631753, 4899.730514821719, 4936.580390666762, 4946.901061978812, 5169.043726910533, 5191.558717509054, 5258.50044245796, 5290.338707661543, 4889.46215916256, 4902.093112774148, 4907.116718990616, 4936.555709986119, 4953.900921981613, 5163.302954101298, 5176.922346164886, 5178.0679477694375, 5180.663256888291, 5228.0, 4992.101421744121, 5118.41138269089, 5118.641695081457, 5242.108841496878, 5253.842384728464, 5036.546710796046, 5039.269305950544, 5041.873953151201, 5077.568406685473, 5094.414142373526, 5022.573081288131, 5037.949620503895, 5039.420466646383, 5060.49395060491, 5085.694858308513, 4810.975945120252, 4874.5856602189215, 4944.92582611254, 4978.626603004716, 5032.0690672225755, 5078.746062696924, 5084.491550844886, 5093.4651861554, 5116.9744151279, 5130.204818253177, 4935.679180853233, 4969.552740253394, 4971.701697898137, 4976.825811096594, 5031.798728050837], "value": 4783.551553981151, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.1597603594608, 565.8274226360958, 569.1576466829096, 580.2167074449494, 585.1252377695346, 29862.253443663918, 40507.59492405075, 42008.15983680324, 42012.15975680488, 45659.54340456594, 41973.37039944403, 42314.0, 42576.14847703044, 42606.57393426065, 42622.57377426225, 7687.461877668551, 7797.337226335769, 7825.6087195640275, 7829.138794732575, 7829.608519573999, 7467.813304667372, 9503.80992380152, 9725.0761177688, 9735.0, 10003.549840257207, 9971.60113595459, 10024.799504009952, 10046.799064018714, 10048.598056077748, 10051.748706282366, 9859.161971232383, 9864.802703945918, 9906.752331191707, 9934.35426697266, 9938.0, 9823.607055717834, 9877.753056173582, 9883.950580247052, 9887.060729230712, 9896.059874311928, 38430.231395371935, 38605.80697096525, 38794.418083728764, 38827.611723882685, 38840.41739373912, 3099.6900309969046, 3105.8602362893726, 3204.7275981541598, 3231.951520727191, 3332.9833350833333, 29817.25456863574, 30143.0, 30411.2397190072, 30503.084907452812, 30625.693743062508, 3229.1119942016135, 3281.2453135778665, 3295.0773783340464, 3304.80171189727, 3307.6361600223954, 238560.0, 241939.0, 243122.0, 243341.0, 244399.0, 54658.0, 55034.0, 55133.0, 55174.0, 55232.72383638056, 57875.71062144746, 57935.0, 58156.709216454496, 58248.0, 58334.4166558329, 14778.334974926154, 15065.623359416102, 15071.171085590178, 15082.773758393632, 15083.321250543751, 9231.215346695471, 9715.02849715037, 9746.561404736804, 9820.508974551243, 10594.4702764863, 16242.918785405996, 16925.830741692673, 17032.65934681324, 17048.57378565521, 17247.0, 5508.097792964185, 5510.29995302299, 5521.889562208814, 5552.91670624941, 5680.68756218412, 803.0, 878.499255424402, 888.8313808239337, 919.6597259014208, 920.9823145424343, 28215.57676634852, 28335.149945501667, 28423.857880710464, 28746.137615871558, 28815.855920720263, 996.257787947969, 999.5052449037773, 1009.4750729620556, 1012.5595366015807, 1032.992831988805, 15029.549113526611, 15288.770668439982, 15390.615234619225, 15594.454194103151, 15739.763903541456, 363354.0, 375799.0, 376249.0, 376769.0, 377614.0, 48654.270185947236, 48938.75530622395, 48989.755051224514, 49002.26496602554, 49035.5096449031, 1098.8351747237978, 1178.9233699809486, 1184.466989854586, 1205.4394706461537, 1208.2689972566645, 26853.194404167905, 29138.708612914448, 29313.267168320963, 29677.0, 29908.850455747583, 42573.0, 43313.0, 43479.782601086794, 43569.56430435782, 43688.78155609201, 312404.0, 316012.0, 317216.0, 317496.0, 317581.0, 32288.515672265406, 33356.0, 36830.0, 37140.0, 37632.81183594064, 38393.23213535769, 41350.0, 41654.0, 41986.0, 42497.36253956131, 34191.264698823536, 34909.127271818405, 35534.0, 35562.64437355593, 35628.82185589159, 35747.82126089353, 35854.0, 35907.64092359043, 36143.81928090448, 36348.818255908554, 34732.47901281432, 35015.82492087523, 35158.12104697403, 35256.471152932216, 35869.82065089658, 30280.0, 32657.836710817246, 32818.0, 32852.0, 33009.174770630925, 24692.753072469044, 25225.369365766004, 25253.494930101664, 25516.362090947874, 25548.23355299344], "value": 18022.89737689399, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.9048266485382, 346.4237718381365, 350.95963964144113, 355.7708118450753, 371.2908345060934, 13018.869811301884, 16461.094639794806, 16472.094034828093, 17106.914465427657, 18094.638107237846, 16429.753553696704, 16711.498655040337, 16925.238364273606, 16961.66076678466, 16994.235259413326, 4926.359573255471, 4926.852194434164, 5092.9236061459105, 5106.336176297076, 5110.28456016158, 3681.4845921571, 4792.90414191716, 5053.267276244942, 5551.2228288039505, 5850.795222167225, 5860.73626686798, 5877.0, 5893.351731309553, 5904.586678932476, 5907.556933230004, 5082.23766435034, 5279.9208011879855, 5294.1529355303355, 5428.077226871442, 5901.026330655437, 5259.316288882459, 5263.0526505229045, 5275.0, 5275.419703832576, 5279.86800329991, 11659.12556558253, 11696.941515292454, 11860.110491713156, 11900.702482437922, 12021.639350819489, 1905.7141428785656, 1961.2155137944794, 1978.357033963953, 1985.9510874972684, 2049.7847725988854, 8660.090690477535, 9449.716508504756, 9676.0, 11753.824617538177, 12935.353232338439, 1718.9656206875918, 1738.6435780664933, 1766.0816375484676, 1789.910504474771, 1822.7812662480587, 65428.67285663589, 66563.0, 68537.65731171361, 68701.31298686999, 71003.28996710018, 9536.28477864163, 9581.856272155923, 9642.951785241028, 9939.155171810333, 10458.63394781179, 12691.492340306284, 12723.04577156717, 12747.42636581356, 12756.170848894792, 12785.808212876815, 6847.486438517131, 7163.641817909083, 7253.202147763847, 7293.088363954505, 7467.626618669045, 6926.792196234121, 6958.7912362628185, 7139.92860071403, 7194.820129496805, 7224.566526008456, 4082.8775136745944, 4169.124483858423, 4215.515215750167, 4306.246406878784, 4333.263345231318, 1722.46603552899, 1754.1492376197534, 1761.4803632928317, 1769.3541857222021, 1772.1936518883876, 811.7605306434616, 826.710651272062, 843.5950743643085, 854.3421565394735, 876.2245412809582, 17657.38199163023, 18098.27606895736, 18107.18517666708, 18391.02291755185, 18527.351542695942, 811.6428771340592, 830.4892491117919, 862.9180227878342, 865.0354854337369, 867.085225087526, 9538.475383853816, 10210.453226233496, 10225.386476811414, 10325.63860264887, 10425.374477531372, 392674.0, 404991.0, 407021.0, 408159.0, 408355.0, 45978.54021459743, 67452.662736686, 78894.0, 80048.0, 80279.0, 855.8758979947997, 883.7481317824518, 888.7378223424106, 892.2727976698969, 895.2524641924066, 15990.360385584912, 16981.320747169975, 17305.13474326304, 17324.133793310033, 17434.825651743322, 38800.6119938797, 40519.0, 40869.59130408658, 40919.795401022806, 41588.16823663449, 55254.72372638111, 56858.7157064212, 57064.0, 57085.71457142688, 57671.0, 7459.962700186465, 7652.923470765221, 7679.540887231408, 7810.3751699865015, 8088.514689118671, 10350.948245258725, 12467.812982805084, 12637.684057898627, 12676.23942563449, 12747.298898560668, 9867.901320986699, 10174.796504070026, 10215.13171380441, 10265.281430299807, 10386.376817390981, 10595.523201455799, 10692.518836652214, 10748.785024299626, 10888.128949683847, 11166.218364714392, 10298.536565854705, 10486.52810623539, 10672.092872105648, 10697.083655019425, 10912.181586380895, 7556.65995030214, 7624.771256862303, 7720.884186737316, 7909.564973926489, 8154.469959452854, 9188.127127922837, 9636.0, 9641.807163856824, 10501.579936802442, 10969.945150274198], "value": 8149.937223653893, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.3643023842717, 1340.544214966911, 1392.6796836727553, 1453.316941037712, 1675.622984828413, 6416.294207637162, 7253.383462405695, 7603.0496187976505, 7604.3916486681, 7803.0, 7574.583397913113, 7647.120581133171, 7648.961755191216, 7659.463837531375, 7663.463557550974, 2162.7296587926508, 2187.07049503961, 2188.0919418441326, 2188.6607575825774, 2189.179057853305, 2129.552793913272, 2166.7074944882397, 2224.177054489841, 2226.0, 2227.265002549155, 2162.297253392646, 2174.2172817785586, 2180.31320134158, 2180.8364372672036, 2210.171185805323, 2155.9568808623817, 2158.104386679526, 2159.3090211132444, 2162.0270878104757, 2162.0703097668074, 2074.844386670991, 2127.478767701923, 2132.7120838686733, 2134.882581458019, 2136.102836808544, 7492.887606685904, 7620.276073772982, 7662.0, 7722.3049925506975, 7724.6137693115115, 4172.436721042651, 4332.371806088131, 4344.565543445662, 4346.847860324873, 4349.13017396522, 2589.3526618345413, 2732.8770205340807, 2758.8620568971673, 2768.1280396675184, 2770.362816552184, 846.6697987784769, 863.5380071661693, 866.2420382165606, 874.868769684546, 891.064382398479, 10075.546600402926, 10213.33613315132, 10235.283530152967, 10236.948815255875, 10241.12950399217, 3702.500162478085, 3912.902177445587, 4006.779627120478, 4007.599240075969, 4014.197160567898, 8149.103598604149, 8149.7147599833725, 8155.959220203979, 8161.510309381456, 8172.346212303001, 4328.956710432918, 4336.804843782037, 4340.153670034313, 4344.782760861945, 4350.782460876943, 3485.6514348564942, 3624.1120925373452, 3864.7101467390057, 4023.6177563131455, 4028.0131367815075, 3324.7173990211104, 3326.9500957485657, 3470.878519251814, 3474.739394545419, 3493.8951831445097, 1024.948752562369, 1032.9173666106844, 1046.8796088449926, 1053.3627155570923, 1066.1630619963446, 654.6922946215271, 711.3562226185311, 799.5482552358015, 829.7593697827563, 840.0213750980162, 5009.323741294878, 5075.137226671474, 5102.08162530748, 5187.144121220032, 5228.2680424740565, 380.2490082087854, 385.4719034922119, 386.08112691793355, 386.26802209812246, 391.12973633665433, 3455.4298540740997, 3470.6182319944787, 3540.168060505779, 3596.6762991330907, 3669.9266014679556, 9175.908240917639, 9558.091981261769, 9614.375065620712, 9653.1794797443, 9666.565004574812, 9591.808163836684, 9596.23230141587, 9600.903990960142, 9601.703769991102, 9608.519574021411, 7179.138503379523, 7277.126744790659, 7329.706811727471, 7349.853002939912, 7354.448416368794, 5231.712255825966, 5289.338832645919, 5293.973530132479, 5297.337832770903, 5307.416184219655, 8554.615042323236, 8635.222829945335, 8734.344924130843, 8770.035296117294, 8798.692045778367, 8890.777730556787, 8922.643094276156, 8935.955320223356, 8976.41653292534, 8982.0, 5433.646812957145, 5846.123081537633, 6279.434850863444, 6336.873262534631, 6343.746250149942, 6976.267491913276, 7359.632018398952, 7361.631918403951, 7380.114386273682, 7391.852162956603, 6598.90101648466, 6615.636140012345, 6631.867362652816, 6736.157980252468, 6818.897716534157, 6556.475481961527, 6563.212414510289, 6581.638009909309, 6608.7356505739235, 6611.966940165268, 6053.273607167168, 6133.53998450127, 6140.754369825157, 6140.907886381798, 6141.785037523665, 4495.2358099122575, 4547.067851090453, 4607.907841843212, 4653.348531205702, 4676.55572720591, 4389.692721509591, 4477.104579084261, 4509.616682582017, 4575.450945886515, 4697.13103075932], "value": 3910.8379922033528, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.4448098448518, 285.61442053228143, 290.20628580831425, 291.4898926877962, 292.8155262184826, 4895.21676531755, 4905.950940490594, 4927.6550641455115, 4927.950720492794, 4937.777799998999, 4792.257200133976, 4802.83190088347, 4840.225563909775, 4846.733429661367, 4862.878428039301, 3574.2672752085823, 3679.411294192916, 3712.4407748745457, 3760.5111335526344, 3796.126890815114, 3720.7767533947913, 3777.7911068458106, 3786.3752480840767, 3799.9430008549894, 3814.5803961564206, 3727.3477141500266, 3732.346839303125, 3739.738218324718, 3741.681957033642, 3767.284215998965, 3609.9458508122398, 3649.59854416014, 3740.139767853409, 3758.586555478895, 3763.9811800941093, 3299.934001319984, 3307.8918562281665, 3313.5858017747782, 3322.1362445764034, 3329.6836800503916, 4747.169245382044, 4767.690100143514, 4768.380110585602, 4772.689775164603, 4785.994941062381, 4188.62302392783, 4337.262665346867, 4337.696361254713, 4340.696151269412, 4361.149575832714, 5022.924656130161, 5052.393712754456, 5055.620828437882, 5057.5448209660935, 5067.5185857343495, 3639.9818000909827, 3640.9271814563826, 3643.0, 3645.2891686121216, 3655.3603119454256, 5120.539151476422, 5285.973570132163, 5344.652597581184, 5349.4650534946195, 5354.437784032699, 3668.944965825515, 3683.171286460525, 3693.778373297611, 3694.8706795262574, 3697.5193224880595, 3742.2515496900182, 3743.21392507571, 3744.700423966076, 3749.7937613430977, 3758.229562939591, 4309.159713855768, 4310.44823863409, 4312.110885706584, 4320.287152619845, 4331.480222373335, 4905.166121759309, 4983.103041452501, 5010.849674509771, 5103.515166059218, 5112.8466146014935, 1265.5380786013038, 1288.3171918883006, 1290.1356091418772, 1291.9418626161657, 1294.1911305434103, 800.7917941335295, 820.9655833649645, 833.9916600834035, 841.9747407577782, 842.6797816829566, 4302.82788688449, 4403.207422663952, 4411.360352748898, 4438.911221775546, 4459.576340247671, 5165.638405311667, 5172.482751724798, 5174.275601415805, 5188.481151884781, 5228.55557277628, 4418.734875907456, 4426.269665505156, 4440.755758433253, 4440.955590444054, 4485.708428952108, 2617.2148355493277, 2754.724527547269, 2758.641376621026, 2760.903368382137, 2771.4041481081663, 4930.2358134488495, 4945.184044632667, 4953.6532442729385, 4954.083494553519, 4970.17992031318, 5260.500252476008, 5280.1815718563685, 5404.432534583891, 5434.592405569598, 5442.537384322377, 4881.829135980294, 4900.779464924087, 4903.730294833747, 4911.45973942866, 4918.655694101379, 5213.462028701618, 5216.295800066942, 5238.659487133325, 5247.763850626808, 5257.684538927677, 4850.320955066223, 5112.261830977485, 5141.53726164647, 5174.404943431403, 5192.221166824856, 4947.431045429677, 4958.776855041459, 4964.280179374043, 4976.208564916699, 5000.64995450315, 3678.2459595782266, 3682.6317368262958, 3690.7820419262116, 3702.3705969985704, 3704.740668153311, 5074.213496907985, 5266.631335806457, 5344.225087362389, 5352.625316227826, 5360.195970604441, 5041.168207245763, 5041.42023667283, 5049.368828896388, 5050.545450909436, 5059.418166910705, 5058.367704036996, 5062.594992400673, 5065.214891691794, 5077.213031980049, 5095.261187127771, 4702.202189697125, 4950.158473059517, 5002.974390249918, 5005.274235235943, 5032.3961124665275, 4853.126437241331, 4924.236743304794, 5059.519345662156, 5070.264811602223, 5086.618503612318, 4973.303737476828, 4977.278294647183, 4978.286833675728, 5010.949890501049, 5031.597472202288], "value": 3811.9533243381716, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.3925934805847, 635.6916895305776, 641.2305233719537, 662.5991275278457, 743.2456057102039, 12129.272243665375, 12682.936585317071, 12978.221306721603, 13029.674258143552, 13152.210867347954, 13104.14823036502, 13256.93371533141, 13259.602211933658, 13271.071025028252, 13280.402381892814, 624.9843753906143, 769.8691222492175, 790.2137373313561, 791.6793698552067, 792.8335049639554, 750.898628685126, 786.2884089898622, 788.3377962511489, 788.6332855222321, 792.5165648954134, 834.4409245805294, 835.6699103853974, 836.7155167243136, 836.8953880764905, 837.4054421360842, 656.4289068510426, 825.8018075661857, 828.9129641387627, 829.3986859526855, 829.5396055189367, 579.9304083509963, 599.053495477145, 601.7562887030759, 601.9187409699722, 602.4908951935652, 12813.231206127663, 12826.0, 12828.422720977578, 12835.165714228639, 12850.228986260854, 11572.479238434207, 11989.520419183222, 12164.635060948098, 12331.260124392566, 13024.088313818036, 11254.26847254934, 11302.152338574557, 11315.434228288635, 11495.88504114965, 11797.115216358721, 3997.84008639657, 4012.4382586437923, 4046.1300820323772, 4090.2228576570656, 4105.158442519277, 53151.73424132893, 55230.72384638091, 55347.44652553504, 68571.65714171447, 69402.30597694009, 10319.896801032044, 10439.321444106108, 10509.894901050891, 10751.569937202425, 10888.128949684005, 18904.054797260083, 18914.0, 19021.714674279898, 19110.904445477685, 19127.2349106037, 6976.51164418496, 7048.224695283515, 7168.4265258780215, 7251.021112149898, 7398.223186565441, 3961.9405708914387, 4019.055521952339, 4032.475778148822, 4034.919301613951, 4065.8576949807207, 2774.8057635965692, 2839.034728192383, 2857.3856620826623, 2862.069827306134, 2870.167651381118, 506.1168261383835, 507.84256880367207, 508.64903216780306, 513.8073222541547, 515.0985774893935, 564.2354609504063, 618.517556306073, 621.7388696747377, 630.8864404407159, 633.6134957675814, 7773.68905243784, 7831.960840195877, 8249.958750206331, 8339.499630022097, 8466.830663386821, 531.1236459841216, 574.8160588611688, 615.7352338494491, 618.7710547097513, 635.4566845347254, 3755.211405604799, 3796.4115562087923, 3801.5248093988253, 3811.2187001664593, 4043.9191216175514, 104010.0, 104014.8394064244, 104486.0, 105972.47013765037, 106170.46914765377, 87917.0, 88400.5579972096, 91130.0, 94972.52513737387, 95038.52480737552, 69396.30603693899, 76533.0, 76712.23287767051, 79637.0, 81196.59401702836, 6994.3355381240735, 7153.1416230050645, 7242.637868106468, 7253.238409966877, 7284.417246620364, 44745.328820068375, 44913.550864490935, 45061.549384507045, 46535.301970469794, 48362.5163748358, 40535.391969121076, 41292.0, 47794.0, 53747.73126134344, 56259.0, 10798.190135740007, 10802.297850639683, 11105.777884442428, 11122.499487522919, 11306.660800176009, 12099.0, 12123.878761212274, 12382.62852114438, 13260.602181934557, 13323.13399629021, 11449.427528623703, 11849.289042657469, 11958.64124076279, 12218.389080546114, 12225.266484010988, 11934.224275422417, 12082.577109801116, 12265.448054837376, 12294.81557776652, 12859.29273889945, 11153.163512736415, 11583.189176757545, 11639.5344186235, 11660.591879284184, 11915.821262680893, 9953.950230248802, 10046.497675116361, 10050.775026430014, 10143.84784228252, 10454.477276136315, 9231.630734770803, 10177.134943529883, 10423.0, 10479.790404192026, 10495.317804342692], "value": 6596.933422483668, "unit": "score"}], "name": "dromaeo_css", "value": 6406.047766882447, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 115.0, 117.0, 117.0, 116.0, 116.0, 115.0, 115.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 124.0, 193.0, 125.0, 125.0, 145.0, 129.0, 167.0, 123.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 162.0, 163.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 134.0, 75.0, 76.0, 74.0, 75.0, 101.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 125.0, 85.0, 87.0, 85.0, 118.0, 85.0, 87.0, 134.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 62.0, 63.0, 63.0, 62.0, 62.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 129.0, 131.0, 127.0, 130.0, 129.0, 128.0, 189.0, 141.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 167.0, 169.0, 170.0, 168.0, 166.0, 164.0, 172.0, 166.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 69.0, 68.0, 68.0, 66.0, 66.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1536.6999999999998, "alertThreshold": 2.0}]} 03:45:36 INFO - Return code: 0 03:45:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:36 INFO - # TBPL SUCCESS # 03:45:36 INFO - Running post-action listener: _resource_record_post_action 03:45:36 INFO - [mozharness: 2016-08-04 10:45:36.352997Z] Finished run-tests step (success) 03:45:36 INFO - Running post-run listener: _resource_record_post_run 03:45:36 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 533921792; Read time: 212; Write time: 444748 03:45:36 INFO - TinderboxPrint: CPU usage
13.0% 03:45:36 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 212 03:45:36 INFO - TinderboxPrint: I/O write bytes / time
533,921,792 / 444,748 03:45:36 INFO - TinderboxPrint: CPU idle
8,334.0 (87.0%) 03:45:36 INFO - TinderboxPrint: CPU user
1,200.5 (12.5%) 03:45:36 INFO - TinderboxPrint: Swap in / out
0 / 0 03:45:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245719040; Read time: 0; Write time: 274488 03:45:36 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283754496; Read time: 200; Write time: 169416 03:45:36 INFO - Running post-run listener: _upload_blobber_files 03:45:36 INFO - Blob upload gear active. 03:45:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:36 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:45:36 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:45:36 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:45:37 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:45:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:45:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:38 INFO - (blobuploader) - INFO - Done attempting. 03:45:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:45:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:45:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:38 INFO - (blobuploader) - INFO - Done attempting. 03:45:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:45:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:45:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:46 INFO - (blobuploader) - INFO - Done attempting. 03:45:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:46 INFO - Return code: 0 03:45:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e0503e96b9d8fbe5aad6bdb2c21dbf8d2f6744412deb4e5d37e312fcd0e2d79ec58f79b168160690ce6c39ab92624beaa101e8092cb387ae6944aec9dd7519c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/189b78efa41c712e834914ca5fd19b35880205a14981e8f1bf4f1fac76948cb3ffef45f3631c7dd61816f815dd7a4ef4e0ec0fda92527bd9e71c58f11b7e048d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a3b8c8121edc86d30854860b4d86b1f0111ed411c989a45b3a9194af242434fe8a1b1768c4821f8190b7291bfc50e0b041cbf96d1d552e0fa5d4474e6f26f75"} 03:45:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:46 INFO - Contents: 03:45:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e0503e96b9d8fbe5aad6bdb2c21dbf8d2f6744412deb4e5d37e312fcd0e2d79ec58f79b168160690ce6c39ab92624beaa101e8092cb387ae6944aec9dd7519c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/189b78efa41c712e834914ca5fd19b35880205a14981e8f1bf4f1fac76948cb3ffef45f3631c7dd61816f815dd7a4ef4e0ec0fda92527bd9e71c58f11b7e048d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a3b8c8121edc86d30854860b4d86b1f0111ed411c989a45b3a9194af242434fe8a1b1768c4821f8190b7291bfc50e0b041cbf96d1d552e0fa5d4474e6f26f75"} 03:45:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:46 INFO - Copying logs to upload dir... 03:45:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.457722 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-04 03:45:46.478619) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 03:45:46.482664) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958 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/3e0503e96b9d8fbe5aad6bdb2c21dbf8d2f6744412deb4e5d37e312fcd0e2d79ec58f79b168160690ce6c39ab92624beaa101e8092cb387ae6944aec9dd7519c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/189b78efa41c712e834914ca5fd19b35880205a14981e8f1bf4f1fac76948cb3ffef45f3631c7dd61816f815dd7a4ef4e0ec0fda92527bd9e71c58f11b7e048d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a3b8c8121edc86d30854860b4d86b1f0111ed411c989a45b3a9194af242434fe8a1b1768c4821f8190b7291bfc50e0b041cbf96d1d552e0fa5d4474e6f26f75"} build_url:https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011108 build_url: 'https://queue.taskcluster.net/v1/task/HnXpmnO3RqGBea3EN1kd0A/artifacts/public/build/firefox-51.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/3e0503e96b9d8fbe5aad6bdb2c21dbf8d2f6744412deb4e5d37e312fcd0e2d79ec58f79b168160690ce6c39ab92624beaa101e8092cb387ae6944aec9dd7519c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/189b78efa41c712e834914ca5fd19b35880205a14981e8f1bf4f1fac76948cb3ffef45f3631c7dd61816f815dd7a4ef4e0ec0fda92527bd9e71c58f11b7e048d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a3b8c8121edc86d30854860b4d86b1f0111ed411c989a45b3a9194af242434fe8a1b1768c4821f8190b7291bfc50e0b041cbf96d1d552e0fa5d4474e6f26f75"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 03:45:46.509853) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:45:46.510292) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1470304209.907084-1499185958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 03:45:46.591097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 03:45:46.591453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 03:45:46.591782) ========= ========= Total master_lag: 0.16 =========