builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1470082284.61 results: success (0) buildid: 20160801100441 builduid: dff5b688c76c4f79ad71bd5b2430d5b4 revision: cace1687008bb7f514b76017f62895c23ec18c2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:24.607160) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:24.608270) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:24.609041) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:24.624774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:24.625371) ========= 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=32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 13:11:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-01 13:11:26 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094896 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:24.739011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:24.739346) ========= 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=32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015469 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:24.789006) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 13:11:24.789372) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cace1687008bb7f514b76017f62895c23ec18c2c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cace1687008bb7f514b76017f62895c23ec18c2c --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=32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 13:11:26,483 truncating revision to first 12 chars 2016-08-01 13:11:26,483 Setting DEBUG logging. 2016-08-01 13:11:26,483 attempt 1/10 2016-08-01 13:11:26,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cace1687008b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 13:11:27,936 unpacking tar archive at: mozilla-aurora-cace1687008b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.785196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 13:11:26.588943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:26.589286) ========= script_repo_revision: cace1687008bb7f514b76017f62895c23ec18c2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:26.589730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:26.590028) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:26.599669) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-08-01 13:11:26.599972) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:11:28 INFO - MultiFileLogger online at 20160801 13:11:28 in /builds/slave/test 13:11:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:11:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:11:28 INFO - {'append_to_log': False, 13:11:28 INFO - 'base_work_dir': '/builds/slave/test', 13:11:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:11:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:11:28 INFO - 'branch': 'Mozilla-Aurora', 13:11:28 INFO - 'buildbot_json_path': 'buildprops.json', 13:11:28 INFO - 'config_files': ('talos/linux_config.py',), 13:11:28 INFO - 'default_actions': ('clobber', 13:11:28 INFO - 'read-buildbot-config', 13:11:28 INFO - 'download-and-extract', 13:11:28 INFO - 'populate-webroot', 13:11:28 INFO - 'create-virtualenv', 13:11:28 INFO - 'install', 13:11:28 INFO - 'run-tests'), 13:11:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:11:28 INFO - 'download_minidump_stackwalk': True, 13:11:28 INFO - 'download_symbols': 'ondemand', 13:11:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:11:28 INFO - 'tooltool.py': '/tools/tooltool.py', 13:11:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:11:28 INFO - '/tools/misc-python/virtualenv.py')}, 13:11:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:11:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:11:28 INFO - 'installer_path': 'installer.exe', 13:11:28 INFO - 'log_level': 'info', 13:11:28 INFO - 'log_name': 'talos', 13:11:28 INFO - 'log_to_console': True, 13:11:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:11:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:11:28 INFO - 'opt_config_files': (), 13:11:28 INFO - 'pip_index': False, 13:11:28 INFO - 'sps_profile': False, 13:11:28 INFO - 'sps_profile_interval': 0, 13:11:28 INFO - 'suite': 'dromaeojs', 13:11:28 INFO - 'system_bits': '32', 13:11:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:11:28 INFO - 'title': 'talos-linux64-ix-008', 13:11:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:11:28 INFO - 'use_talos_json': True, 13:11:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:11:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:11:28 INFO - 'work_dir': 'build'} 13:11:28 INFO - [mozharness: 2016-08-01 20:11:28.382993Z] Running clobber step. 13:11:28 INFO - Running pre-action listener: _resource_record_pre_action 13:11:28 INFO - Running main action method: clobber 13:11:28 INFO - rmtree: /builds/slave/test/build 13:11:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:11:28 INFO - Running post-action listener: _resource_record_post_action 13:11:28 INFO - [mozharness: 2016-08-01 20:11:28.841185Z] Finished clobber step (success) 13:11:28 INFO - [mozharness: 2016-08-01 20:11:28.841286Z] Running read-buildbot-config step. 13:11:28 INFO - Running pre-action listener: _resource_record_pre_action 13:11:28 INFO - Running main action method: read_buildbot_config 13:11:28 INFO - Using buildbot properties: 13:11:28 INFO - { 13:11:28 INFO - "project": "", 13:11:28 INFO - "product": "firefox", 13:11:28 INFO - "script_repo_revision": "production", 13:11:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:11:28 INFO - "repository": "", 13:11:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:11:28 INFO - "buildid": "20160801100441", 13:11:28 INFO - "pgo_build": "True", 13:11:28 INFO - "basedir": "/builds/slave/test", 13:11:28 INFO - "buildnumber": 445, 13:11:28 INFO - "slavename": "talos-linux64-ix-008", 13:11:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:11:28 INFO - "platform": "ubuntu64_hw", 13:11:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:11:28 INFO - "branch": "mozilla-aurora", 13:11:28 INFO - "repo_path": "releases/mozilla-aurora", 13:11:28 INFO - "revision": "cace1687008bb7f514b76017f62895c23ec18c2c", 13:11:28 INFO - "stage_platform": "linux64-pgo", 13:11:28 INFO - "builduid": "dff5b688c76c4f79ad71bd5b2430d5b4", 13:11:28 INFO - "slavebuilddir": "test" 13:11:28 INFO - } 13:11:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 13:11:28 INFO - Running post-action listener: _resource_record_post_action 13:11:28 INFO - [mozharness: 2016-08-01 20:11:28.844049Z] Finished read-buildbot-config step (success) 13:11:28 INFO - [mozharness: 2016-08-01 20:11:28.844145Z] Running download-and-extract step. 13:11:28 INFO - Running pre-action listener: _resource_record_pre_action 13:11:28 INFO - Running main action method: download_and_extract 13:11:28 INFO - mkdir: /builds/slave/test/build/tests 13:11: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')]} 13:11:28 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:11:29 INFO - Downloaded 1361 bytes. 13:11:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:11:29 INFO - Using the following test package requirements: 13:11:29 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:11:29 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:11:29 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:11:29 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'jsshell-linux-x86_64.zip'], 13:11:29 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:11:29 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:11:29 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:11:29 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:11:29 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:11:29 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:11:29 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:11:29 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')]} 13:11:29 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:11:30 INFO - Downloaded 21764987 bytes. 13:11:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:11:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:11:31 INFO - Return code: 0 13:11:31 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:11: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')]} 13:11:31 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:11:32 INFO - Downloaded 21764987 bytes. 13:11:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:11:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:11:33 INFO - Return code: 0 13:11:33 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')]} 13:11:33 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:11:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:11:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:11:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:11:34 INFO - Downloaded 14413723 bytes. 13:11:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:11:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:11:35 INFO - Return code: 0 13:11: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')]} 13:11:35 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:11:36 INFO - Downloaded 63777811 bytes. 13:11:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:36 INFO - mkdir: /builds/slave/test/properties 13:11:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:11:36 INFO - Writing to file /builds/slave/test/properties/build_url 13:11:36 INFO - Contents: 13:11:36 INFO - build_url:https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:37 INFO - Running post-action listener: _resource_record_post_action 13:11:37 INFO - Running post-action listener: set_extra_try_arguments 13:11:37 INFO - [mozharness: 2016-08-01 20:11:37.159575Z] Finished download-and-extract step (success) 13:11:37 INFO - [mozharness: 2016-08-01 20:11:37.159810Z] Running populate-webroot step. 13:11:37 INFO - Running pre-action listener: _resource_record_pre_action 13:11:37 INFO - Running main action method: populate_webroot 13:11:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:11:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:11:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:11:37 INFO - '--tppagecycles', 13:11:37 INFO - '7'], 13:11:37 INFO - 'tests': ['tsvgm']}}, 13:11:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:11:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:11:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:11:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:11:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:37 INFO - 'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:37 INFO - 'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['damp', 'tps']}, 13:11:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:37 INFO - 'tests': ['damp', 'tps']}, 13:11:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['dromaeo_dom']}, 13:11:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:11:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['basic_compositor_video']}, 13:11:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:11:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['a11yr', 13:11:37 INFO - 'ts_paint', 13:11:37 INFO - 'tpaint', 13:11:37 INFO - 'sessionrestore', 13:11:37 INFO - 'sessionrestore_no_auto_restore', 13:11:37 INFO - 'tabpaint']}, 13:11:37 INFO - 'other-e10s': {'tests': ['a11yr', 13:11:37 INFO - 'ts_paint', 13:11:37 INFO - 'tpaint', 13:11:37 INFO - 'sessionrestore', 13:11:37 INFO - 'sessionrestore_no_auto_restore', 13:11:37 INFO - 'tabpaint']}, 13:11:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:11:37 INFO - 'ts_paint', 13:11:37 INFO - 'tpaint', 13:11:37 INFO - 'sessionrestore', 13:11:37 INFO - 'sessionrestore_no_auto_restore', 13:11:37 INFO - 'tabpaint']}, 13:11:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:11:37 INFO - 'ts_paint', 13:11:37 INFO - 'tpaint', 13:11:37 INFO - 'sessionrestore', 13:11:37 INFO - 'sessionrestore_no_auto_restore', 13:11:37 INFO - 'tabpaint']}, 13:11:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['a11yr', 13:11:37 INFO - 'ts_paint', 13:11:37 INFO - 'tpaint', 13:11:37 INFO - 'sessionrestore', 13:11:37 INFO - 'sessionrestore_no_auto_restore', 13:11:37 INFO - 'tabpaint']}, 13:11:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['a11yr', 13:11:37 INFO - 'ts_paint', 13:11:37 INFO - 'tpaint', 13:11:37 INFO - 'sessionrestore', 13:11:37 INFO - 'sessionrestore_no_auto_restore', 13:11:37 INFO - 'tabpaint']}, 13:11:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['tsvgx', 13:11:37 INFO - 'tsvgr_opacity', 13:11:37 INFO - 'tart', 13:11:37 INFO - 'tscrollx', 13:11:37 INFO - 'cart']}, 13:11:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:11:37 INFO - 'tsvgr_opacity', 13:11:37 INFO - 'tart', 13:11:37 INFO - 'tscrollx', 13:11:37 INFO - 'cart']}, 13:11:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:37 INFO - 'talos_options': ['--disable-e10s'], 13:11:37 INFO - 'tests': ['tp5o']}, 13:11:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:37 INFO - 'tests': ['tp5o']}, 13:11:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:37 INFO - 'talos_options': ['--disable-e10s', 13:11:37 INFO - '--xperf_path', 13:11:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:37 INFO - 'tests': ['tp5n']}, 13:11:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:37 INFO - 'talos_options': ['--xperf_path', 13:11:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:37 INFO - 'tests': ['tp5n']}}, 13:11:37 INFO - 'talos.zip': {'path': '', 13:11:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:11:37 INFO - Running post-action listener: _resource_record_post_action 13:11:37 INFO - [mozharness: 2016-08-01 20:11:37.177130Z] Finished populate-webroot step (success) 13:11:37 INFO - [mozharness: 2016-08-01 20:11:37.177220Z] Running create-virtualenv step. 13:11:37 INFO - Running pre-action listener: _resource_record_pre_action 13:11:37 INFO - Running main action method: create_virtualenv 13:11:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:11:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:11:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:11:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:11:37 INFO - Using real prefix '/usr' 13:11:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:11:37 INFO - Installing distribute.............................................................................................................................................................................................done. 13:11:39 INFO - Installing pip.................done. 13:11:39 INFO - Return code: 0 13:11:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:39 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 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:39 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 13:11:39 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 13:11:39 INFO - Using env: {'DISPLAY': ':0', 13:11:39 INFO - 'HOME': '/home/cltbld', 13:11:39 INFO - 'LANG': 'en_US.UTF-8', 13:11:39 INFO - 'LANGUAGE': 'en_US:en', 13:11:39 INFO - 'LOGNAME': 'cltbld', 13:11:39 INFO - 'MAIL': '/var/mail/cltbld', 13:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:39 INFO - 'MOZ_NO_REMOTE': '1', 13:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:39 INFO - 'NO_EM_RESTART': '1', 13:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:39 INFO - 'PWD': '/builds/slave/test', 13:11:39 INFO - 'SHELL': '/bin/bash', 13:11:39 INFO - 'SHLVL': '1', 13:11:39 INFO - 'TERM': 'linux', 13:11:39 INFO - 'TMOUT': '86400', 13:11:39 INFO - 'USER': 'cltbld', 13:11:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:39 INFO - '_': '/tools/buildbot/bin/python'} 13:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:11:40 INFO - Cleaning up... 13:11:40 INFO - Return code: 0 13:11:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:11:40 INFO - Using env: {'DISPLAY': ':0', 13:11:40 INFO - 'HOME': '/home/cltbld', 13:11:40 INFO - 'LANG': 'en_US.UTF-8', 13:11:40 INFO - 'LANGUAGE': 'en_US:en', 13:11:40 INFO - 'LOGNAME': 'cltbld', 13:11:40 INFO - 'MAIL': '/var/mail/cltbld', 13:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:40 INFO - 'MOZ_NO_REMOTE': '1', 13:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:40 INFO - 'NO_EM_RESTART': '1', 13:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:40 INFO - 'PWD': '/builds/slave/test', 13:11:40 INFO - 'SHELL': '/bin/bash', 13:11:40 INFO - 'SHLVL': '1', 13:11:40 INFO - 'TERM': 'linux', 13:11:40 INFO - 'TMOUT': '86400', 13:11:40 INFO - 'USER': 'cltbld', 13:11:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:40 INFO - '_': '/tools/buildbot/bin/python'} 13:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:40 INFO - Downloading/unpacking psutil>=3.1.1 13:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:11:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:42 INFO - Installing collected packages: psutil 13:11:42 INFO - Running setup.py install for psutil 13:11:42 INFO - building 'psutil._psutil_linux' extension 13:11:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:11:42 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 13:11:42 INFO - building 'psutil._psutil_posix' extension 13:11:42 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 13:11:42 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 13:11:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:42 INFO - Successfully installed psutil 13:11:42 INFO - Cleaning up... 13:11:42 INFO - Return code: 0 13:11:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:42 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 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:42 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 13:11:42 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 13:11:42 INFO - Using env: {'DISPLAY': ':0', 13:11:42 INFO - 'HOME': '/home/cltbld', 13:11:42 INFO - 'LANG': 'en_US.UTF-8', 13:11:42 INFO - 'LANGUAGE': 'en_US:en', 13:11:42 INFO - 'LOGNAME': 'cltbld', 13:11:42 INFO - 'MAIL': '/var/mail/cltbld', 13:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:42 INFO - 'MOZ_NO_REMOTE': '1', 13:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:42 INFO - 'NO_EM_RESTART': '1', 13:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:42 INFO - 'PWD': '/builds/slave/test', 13:11:42 INFO - 'SHELL': '/bin/bash', 13:11:42 INFO - 'SHLVL': '1', 13:11:42 INFO - 'TERM': 'linux', 13:11:42 INFO - 'TMOUT': '86400', 13:11:42 INFO - 'USER': 'cltbld', 13:11:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:42 INFO - '_': '/tools/buildbot/bin/python'} 13:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:11:45 INFO - Installing collected packages: mozsystemmonitor 13:11:45 INFO - Running setup.py install for mozsystemmonitor 13:11:45 INFO - Successfully installed mozsystemmonitor 13:11:45 INFO - Cleaning up... 13:11:45 INFO - Return code: 0 13:11:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:11:45 INFO - Using env: {'DISPLAY': ':0', 13:11:45 INFO - 'HOME': '/home/cltbld', 13:11:45 INFO - 'LANG': 'en_US.UTF-8', 13:11:45 INFO - 'LANGUAGE': 'en_US:en', 13:11:45 INFO - 'LOGNAME': 'cltbld', 13:11:45 INFO - 'MAIL': '/var/mail/cltbld', 13:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:45 INFO - 'MOZ_NO_REMOTE': '1', 13:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:45 INFO - 'NO_EM_RESTART': '1', 13:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:45 INFO - 'PWD': '/builds/slave/test', 13:11:45 INFO - 'SHELL': '/bin/bash', 13:11:45 INFO - 'SHLVL': '1', 13:11:45 INFO - 'TERM': 'linux', 13:11:45 INFO - 'TMOUT': '86400', 13:11:45 INFO - 'USER': 'cltbld', 13:11:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:45 INFO - '_': '/tools/buildbot/bin/python'} 13:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:45 INFO - Downloading/unpacking jsonschema==2.5.1 13:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:11:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:47 INFO - Downloading functools32-3.2.3-2.tar.gz 13:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:11:47 INFO - warning: no files found matching '*.txt' 13:11:47 INFO - no previously-included directories found matching 'build' 13:11:47 INFO - no previously-included directories found matching 'dist' 13:11:47 INFO - no previously-included directories found matching '.git*' 13:11:47 INFO - Installing collected packages: jsonschema, functools32 13:11:47 INFO - Running setup.py install for functools32 13:11:47 INFO - warning: no files found matching '*.txt' 13:11:47 INFO - no previously-included directories found matching 'build' 13:11:47 INFO - no previously-included directories found matching 'dist' 13:11:47 INFO - no previously-included directories found matching '.git*' 13:11:47 INFO - Successfully installed jsonschema functools32 13:11:47 INFO - Cleaning up... 13:11:47 INFO - Return code: 0 13:11:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:11:47 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')]} 13:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:47 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')]} 13:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:47 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 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:47 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 13:11:47 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 13:11:47 INFO - Using env: {'DISPLAY': ':0', 13:11:47 INFO - 'HOME': '/home/cltbld', 13:11:47 INFO - 'LANG': 'en_US.UTF-8', 13:11:47 INFO - 'LANGUAGE': 'en_US:en', 13:11:47 INFO - 'LOGNAME': 'cltbld', 13:11:47 INFO - 'MAIL': '/var/mail/cltbld', 13:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:47 INFO - 'MOZ_NO_REMOTE': '1', 13:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:47 INFO - 'NO_EM_RESTART': '1', 13:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:47 INFO - 'PWD': '/builds/slave/test', 13:11:47 INFO - 'SHELL': '/bin/bash', 13:11:47 INFO - 'SHLVL': '1', 13:11:47 INFO - 'TERM': 'linux', 13:11:47 INFO - 'TMOUT': '86400', 13:11:47 INFO - 'USER': 'cltbld', 13:11:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:47 INFO - '_': '/tools/buildbot/bin/python'} 13:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:11:47 INFO - Cleaning up... 13:11:47 INFO - Return code: 0 13:11:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:11:47 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')]} 13:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:47 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')]} 13:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:47 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 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:47 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 13:11:47 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 13:11:47 INFO - Using env: {'DISPLAY': ':0', 13:11:47 INFO - 'HOME': '/home/cltbld', 13:11:47 INFO - 'LANG': 'en_US.UTF-8', 13:11:47 INFO - 'LANGUAGE': 'en_US:en', 13:11:47 INFO - 'LOGNAME': 'cltbld', 13:11:47 INFO - 'MAIL': '/var/mail/cltbld', 13:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:47 INFO - 'MOZ_NO_REMOTE': '1', 13:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:47 INFO - 'NO_EM_RESTART': '1', 13:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:47 INFO - 'PWD': '/builds/slave/test', 13:11:47 INFO - 'SHELL': '/bin/bash', 13:11:47 INFO - 'SHLVL': '1', 13:11:47 INFO - 'TERM': 'linux', 13:11:47 INFO - 'TMOUT': '86400', 13:11:47 INFO - 'USER': 'cltbld', 13:11:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:47 INFO - '_': '/tools/buildbot/bin/python'} 13:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:11:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:11:50 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 13:11:50 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 13:11:50 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 13:11:50 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 13:11:50 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 13:11:50 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 13:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:11:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:11:50 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 13:11:50 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 13:11:50 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 13:11:50 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 13:11:50 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 13:11:50 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 13:11:50 INFO - Downloading docopt-0.6.1.tar.gz 13:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:11:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:11:51 INFO - Running setup.py install for blobuploader 13:11:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:11:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:11:51 INFO - Running setup.py install for requests 13:11:51 INFO - Running setup.py install for docopt 13:11:51 INFO - Successfully installed blobuploader requests docopt 13:11:51 INFO - Cleaning up... 13:11:51 INFO - Return code: 0 13:11:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11: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')]} 13:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11: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')]} 13:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:51 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 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:51 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 13:11:51 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 13:11:51 INFO - Using env: {'DISPLAY': ':0', 13:11:51 INFO - 'HOME': '/home/cltbld', 13:11:51 INFO - 'LANG': 'en_US.UTF-8', 13:11:51 INFO - 'LANGUAGE': 'en_US:en', 13:11:51 INFO - 'LOGNAME': 'cltbld', 13:11:51 INFO - 'MAIL': '/var/mail/cltbld', 13:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:51 INFO - 'MOZ_NO_REMOTE': '1', 13:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:51 INFO - 'NO_EM_RESTART': '1', 13:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:51 INFO - 'PWD': '/builds/slave/test', 13:11:51 INFO - 'SHELL': '/bin/bash', 13:11:51 INFO - 'SHLVL': '1', 13:11:51 INFO - 'TERM': 'linux', 13:11:51 INFO - 'TMOUT': '86400', 13:11:51 INFO - 'USER': 'cltbld', 13:11:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:51 INFO - '_': '/tools/buildbot/bin/python'} 13:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:51 INFO - Running setup.py (path:/tmp/pip-_vcRYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:51 INFO - Running setup.py (path:/tmp/pip-PvKCcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:52 INFO - Running setup.py (path:/tmp/pip-P0i74c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:52 INFO - Running setup.py (path:/tmp/pip-uI7Uqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:52 INFO - Running setup.py (path:/tmp/pip-xDlpEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:52 INFO - Running setup.py (path:/tmp/pip-M7V_RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:52 INFO - Running setup.py (path:/tmp/pip-Iv7cVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:52 INFO - Running setup.py (path:/tmp/pip-eIp7pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:52 INFO - Running setup.py (path:/tmp/pip-lFwf8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:52 INFO - Running setup.py (path:/tmp/pip-VKRT4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:52 INFO - Running setup.py (path:/tmp/pip-MGmG3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:52 INFO - Running setup.py (path:/tmp/pip-K0Q31x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:52 INFO - Running setup.py (path:/tmp/pip-d9UZMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:52 INFO - Running setup.py (path:/tmp/pip-WeCvr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:52 INFO - Running setup.py (path:/tmp/pip-a25zpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:52 INFO - Running setup.py (path:/tmp/pip-iizTZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:53 INFO - Running setup.py (path:/tmp/pip-FXzrop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:11:53 INFO - Running setup.py install for manifestparser 13:11:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:11:53 INFO - Running setup.py install for mozcrash 13:11:53 INFO - Running setup.py install for mozdebug 13:11:53 INFO - Running setup.py install for mozdevice 13:11:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:11:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:11:53 INFO - Running setup.py install for mozfile 13:11:53 INFO - Running setup.py install for mozhttpd 13:11:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:11:53 INFO - Running setup.py install for mozinfo 13:11:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:11:53 INFO - Running setup.py install for mozInstall 13:11:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:11:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:11:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:11:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:11:53 INFO - Running setup.py install for mozleak 13:11:53 INFO - Running setup.py install for mozlog 13:11:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Running setup.py install for moznetwork 13:11:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Running setup.py install for mozprocess 13:11:54 INFO - Running setup.py install for mozprofile 13:11:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Running setup.py install for mozrunner 13:11:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Running setup.py install for mozscreenshot 13:11:54 INFO - Running setup.py install for moztest 13:11:54 INFO - Running setup.py install for mozversion 13:11:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:11:54 INFO - Cleaning up... 13:11:54 INFO - Return code: 0 13:11:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:54 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 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:54 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 13:11:54 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 13:11:54 INFO - Using env: {'DISPLAY': ':0', 13:11:54 INFO - 'HOME': '/home/cltbld', 13:11:54 INFO - 'LANG': 'en_US.UTF-8', 13:11:54 INFO - 'LANGUAGE': 'en_US:en', 13:11:54 INFO - 'LOGNAME': 'cltbld', 13:11:54 INFO - 'MAIL': '/var/mail/cltbld', 13:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:54 INFO - 'MOZ_NO_REMOTE': '1', 13:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:54 INFO - 'NO_EM_RESTART': '1', 13:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:54 INFO - 'PWD': '/builds/slave/test', 13:11:54 INFO - 'SHELL': '/bin/bash', 13:11:54 INFO - 'SHLVL': '1', 13:11:54 INFO - 'TERM': 'linux', 13:11:54 INFO - 'TMOUT': '86400', 13:11:54 INFO - 'USER': 'cltbld', 13:11:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:54 INFO - '_': '/tools/buildbot/bin/python'} 13:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:55 INFO - Running setup.py (path:/tmp/pip-0vCfTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:55 INFO - Running setup.py (path:/tmp/pip-vVM2ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:55 INFO - Running setup.py (path:/tmp/pip-W_1kuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:55 INFO - Running setup.py (path:/tmp/pip-RdzLD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:55 INFO - Running setup.py (path:/tmp/pip-CeKFav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:55 INFO - Running setup.py (path:/tmp/pip-kjvyXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:55 INFO - Running setup.py (path:/tmp/pip-Qxg6j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:55 INFO - Running setup.py (path:/tmp/pip-_fQohc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:55 INFO - Running setup.py (path:/tmp/pip-MzikUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:55 INFO - Running setup.py (path:/tmp/pip-L6gwvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:55 INFO - Running setup.py (path:/tmp/pip-ngews5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:55 INFO - Running setup.py (path:/tmp/pip-avV2QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:55 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)) 13:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:55 INFO - Running setup.py (path:/tmp/pip-IS1UDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:56 INFO - Running setup.py (path:/tmp/pip-VYriQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:56 INFO - Running setup.py (path:/tmp/pip-YbwfqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:56 INFO - Running setup.py (path:/tmp/pip-bMdwU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:56 INFO - Running setup.py (path:/tmp/pip-JToBCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:56 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)) 13:11:56 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)) 13:11:56 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)) 13:11:56 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)) 13:11:56 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)) 13:11:56 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)) 13:11:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:58 INFO - Downloading blessings-1.6.tar.gz 13:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:11:58 INFO - Installing collected packages: blessings 13:11:58 INFO - Running setup.py install for blessings 13:11:58 INFO - Successfully installed blessings 13:11:58 INFO - Cleaning up... 13:11:58 INFO - Return code: 0 13:11:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:58 INFO - Reading from file tmpfile_stdout 13:11:58 INFO - Current package versions: 13:11:58 INFO - argparse == 1.2.1 13:11:58 INFO - blessings == 1.6 13:11:58 INFO - blobuploader == 1.2.4 13:11:58 INFO - docopt == 0.6.1 13:11:58 INFO - functools32 == 3.2.3-2 13:11:58 INFO - jsonschema == 2.5.1 13:11:58 INFO - manifestparser == 1.1 13:11:58 INFO - mozInstall == 1.12 13:11:58 INFO - mozcrash == 0.17 13:11:58 INFO - mozdebug == 0.1 13:11:58 INFO - mozdevice == 0.48 13:11:58 INFO - mozfile == 1.2 13:11:58 INFO - mozhttpd == 0.7 13:11:58 INFO - mozinfo == 0.9 13:11:58 INFO - mozleak == 0.1 13:11:58 INFO - mozlog == 3.3 13:11:58 INFO - moznetwork == 0.27 13:11:58 INFO - mozprocess == 0.23 13:11:58 INFO - mozprofile == 0.28 13:11:58 INFO - mozrunner == 6.12 13:11:58 INFO - mozscreenshot == 0.1 13:11:58 INFO - mozsystemmonitor == 0.3 13:11:58 INFO - moztest == 0.7 13:11:58 INFO - mozversion == 1.4 13:11:58 INFO - psutil == 3.1.1 13:11:58 INFO - requests == 1.2.3 13:11:58 INFO - wsgiref == 0.1.2 13:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:58 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 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:58 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 13:11:58 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 13:11:58 INFO - Using env: {'DISPLAY': ':0', 13:11:58 INFO - 'HOME': '/home/cltbld', 13:11:58 INFO - 'LANG': 'en_US.UTF-8', 13:11:58 INFO - 'LANGUAGE': 'en_US:en', 13:11:58 INFO - 'LOGNAME': 'cltbld', 13:11:58 INFO - 'MAIL': '/var/mail/cltbld', 13:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:58 INFO - 'MOZ_NO_REMOTE': '1', 13:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:58 INFO - 'NO_EM_RESTART': '1', 13:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:58 INFO - 'PWD': '/builds/slave/test', 13:11:58 INFO - 'SHELL': '/bin/bash', 13:11:58 INFO - 'SHLVL': '1', 13:11:58 INFO - 'TERM': 'linux', 13:11:58 INFO - 'TMOUT': '86400', 13:11:58 INFO - 'USER': 'cltbld', 13:11:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:58 INFO - '_': '/tools/buildbot/bin/python'} 13:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:58 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)) 13:11:58 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)) 13:11:58 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)) 13:11:58 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)) 13:11:58 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)) 13:11:58 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)) 13:11:58 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)) 13:11:58 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)) 13:11:58 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)) 13:11:58 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)) 13:11:58 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)) 13:11:58 INFO - Cleaning up... 13:11:58 INFO - Return code: 0 13:11:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1194180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, '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': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', '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 13:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:11:58 INFO - Using env: {'DISPLAY': ':0', 13:11:58 INFO - 'HOME': '/home/cltbld', 13:11:58 INFO - 'LANG': 'en_US.UTF-8', 13:11:58 INFO - 'LANGUAGE': 'en_US:en', 13:11:58 INFO - 'LOGNAME': 'cltbld', 13:11:58 INFO - 'MAIL': '/var/mail/cltbld', 13:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:58 INFO - 'MOZ_NO_REMOTE': '1', 13:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:58 INFO - 'NO_EM_RESTART': '1', 13:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:58 INFO - 'PWD': '/builds/slave/test', 13:11:58 INFO - 'SHELL': '/bin/bash', 13:11:58 INFO - 'SHLVL': '1', 13:11:58 INFO - 'TERM': 'linux', 13:11:58 INFO - 'TMOUT': '86400', 13:11:58 INFO - 'USER': 'cltbld', 13:11:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:58 INFO - '_': '/tools/buildbot/bin/python'} 13:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:11:59 INFO - Cleaning up... 13:11:59 INFO - Return code: 0 13:11:59 INFO - Running post-action listener: _resource_record_post_action 13:11:59 INFO - Running post-action listener: _start_resource_monitoring 13:11:59 INFO - Starting resource monitoring. 13:11:59 INFO - [mozharness: 2016-08-01 20:11:59.140906Z] Finished create-virtualenv step (success) 13:11:59 INFO - [mozharness: 2016-08-01 20:11:59.141388Z] Running install step. 13:11:59 INFO - Running pre-action listener: _resource_record_pre_action 13:11:59 INFO - Running main action method: install 13:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:59 INFO - Reading from file tmpfile_stdout 13:11:59 INFO - Detecting whether we're running mozinstall >=1.0... 13:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:11:59 INFO - Reading from file tmpfile_stdout 13:11:59 INFO - Output received: 13:11:59 INFO - Usage: mozinstall [options] installer 13:11:59 INFO - Options: 13:11:59 INFO - -h, --help show this help message and exit 13:11:59 INFO - -d DEST, --destination=DEST 13:11:59 INFO - Directory to install application into. [default: 13:11:59 INFO - "/builds/slave/test"] 13:11:59 INFO - --app=APP Application being installed. [default: firefox] 13:11:59 INFO - mkdir: /builds/slave/test/build/application 13:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:12:15 INFO - Reading from file tmpfile_stdout 13:12:15 INFO - Output received: 13:12:15 INFO - /builds/slave/test/build/application/firefox/firefox 13:12:15 INFO - Running post-action listener: _resource_record_post_action 13:12:15 INFO - [mozharness: 2016-08-01 20:12:15.429860Z] Finished install step (success) 13:12:15 INFO - [mozharness: 2016-08-01 20:12:15.430211Z] Running run-tests step. 13:12:15 INFO - Running pre-action listener: _resource_record_pre_action 13:12:15 INFO - Running main action method: run_tests 13:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:12:15 INFO - Python 2.7.3 13:12:15 INFO - Return code: 0 13:12:15 INFO - grabbing minidump binary from tooltool 13:12: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')]} 13:12:15 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 0x11923b0>, '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 0x11932b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1193740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:12:15 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 13:12:15 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 13:12:15 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 13:12:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:12:15 INFO - Return code: 0 13:12:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:12:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:12:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:12:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:12:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 13:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 13:12:15 INFO - Using env: {'DISPLAY': ':0', 13:12:15 INFO - 'HOME': '/home/cltbld', 13:12:15 INFO - 'LANG': 'en_US.UTF-8', 13:12:15 INFO - 'LANGUAGE': 'en_US:en', 13:12:15 INFO - 'LOGNAME': 'cltbld', 13:12:15 INFO - 'MAIL': '/var/mail/cltbld', 13:12:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:12:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:15 INFO - 'MOZ_NO_REMOTE': '1', 13:12:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:15 INFO - 'NO_EM_RESTART': '1', 13:12:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:15 INFO - 'PWD': '/builds/slave/test', 13:12:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:12:15 INFO - 'SHELL': '/bin/bash', 13:12:15 INFO - 'SHLVL': '1', 13:12:15 INFO - 'TERM': 'linux', 13:12:15 INFO - 'TMOUT': '86400', 13:12:15 INFO - 'USER': 'cltbld', 13:12:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742', 13:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:15 INFO - '_': '/tools/buildbot/bin/python'} 13:12:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 13:12:15 INFO - mozversion application_buildid: 20160801100441 13:12:15 INFO - mozversion application_changeset: cace1687008bb7f514b76017f62895c23ec18c2c 13:12:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:12:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:12:15 INFO - mozversion application_name: Firefox 13:12:15 INFO - mozversion application_remotingname: firefox-dev 13:12:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:12:15 INFO - mozversion application_vendor: Mozilla 13:12:15 INFO - mozversion application_version: 50.0a2 13:12:15 INFO - mozversion platform_buildid: 20160801100441 13:12:15 INFO - mozversion platform_changeset: cace1687008bb7f514b76017f62895c23ec18c2c 13:12:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:12:15 INFO - mozversion platform_version: 50.0a2 13:12:15 INFO - using testdate: 1470082335 13:12:15 INFO - actual date: 1470082335 13:12:15 INFO - starting webserver on 'localhost:45155' 13:12:15 INFO - SUITE-START | Running 2 tests 13:12:15 INFO - TEST-START | dromaeo_css 13:12:15 INFO - operating with platform_type : linux_ 13:12:15 INFO - Initialising browser for dromaeo_css test... 13:12:15 INFO - TEST-INFO | started process 30497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeh7PYX/profile http://localhost:45155/getInfo.html) 13:12:19 INFO - PROCESS | 30497 | __metrics Screen width/height:1600/1200 13:12:19 INFO - PROCESS | 30497 | colorDepth:24 13:12:19 INFO - PROCESS | 30497 | Browser inner width/height: 1024/697 13:12:19 INFO - PROCESS | 30497 | __metrics 13:12:20 INFO - PROCESS | 30497 | 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" 13:12:20 INFO - PROCESS | 30497 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:12:21 INFO - TEST-INFO | 30497: exit 0 13:12:21 INFO - Browser initialized. 13:12:21 INFO - Running cycle 1/1 for dromaeo_css test... 13:12:21 INFO - TEST-INFO | started process 30583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeh7PYX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:33 INFO - PROCESS | 30583 | RSS: Main: 145506304 13:12:33 INFO - PROCESS | 30583 | 13:13:24 INFO - PROCESS | 30583 | 1470082404201 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] 13:15:33 INFO - PROCESS | 30583 | Cycle 1(1): loaded http://localhost:45155/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45155/tests/dromaeo/cssquery-ext.html) 13:15:34 INFO - PROCESS | 30583 | RSS: Main: 268267520 13:15:34 INFO - PROCESS | 30583 | 13:18:36 INFO - PROCESS | 30583 | Cycle 1(1): loaded http://localhost:45155/tests/dromaeo/cssquery-ext.html (next: http://localhost:45155/tests/dromaeo/cssquery-jquery.html) 13:18:37 INFO - PROCESS | 30583 | RSS: Main: 235593728 13:18:37 INFO - PROCESS | 30583 | 13:21:39 INFO - PROCESS | 30583 | Cycle 1(1): loaded http://localhost:45155/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45155/tests/dromaeo/cssquery-mootools.html) 13:21:40 INFO - PROCESS | 30583 | RSS: Main: 175308800 13:21:40 INFO - PROCESS | 30583 | 13:24:42 INFO - PROCESS | 30583 | Cycle 1(1): loaded http://localhost:45155/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45155/tests/dromaeo/cssquery-prototype.html) 13:24:42 INFO - PROCESS | 30583 | RSS: Main: 176185344 13:24:42 INFO - PROCESS | 30583 | 13:27:45 INFO - PROCESS | 30583 | Cycle 1(1): loaded http://localhost:45155/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45155/tests/dromaeo/cssquery-yui.html) 13:27:45 INFO - PROCESS | 30583 | RSS: Main: 176472064 13:27:45 INFO - PROCESS | 30583 | 13:30:48 INFO - PROCESS | 30583 | Cycle 1(1): loaded http://localhost:45155/tests/dromaeo/cssquery-yui.html (next: http://localhost:45155/tests/dromaeo/cssquery-dojo.html) 13:30:48 INFO - PROCESS | 30583 | RSS: Main: 258945024 13:30:48 INFO - PROCESS | 30583 | 13:30:48 INFO - PROCESS | 30583 | __start_tp_report 13:30:48 INFO - PROCESS | 30583 | _x_x_mozilla_page_load 13:30:48 INFO - PROCESS | 30583 | _x_x_mozilla_page_load_details 13:30:48 INFO - PROCESS | 30583 | |i|pagename|runs| 13:30:48 INFO - PROCESS | 30583 | |0;dojo.html;3200.775945683802;3219.8712051517928;3224.1617179533328;3243.675632436758;3264.102371847742;5590.245316882219;5671.376148623648;5683.232763576921;5699.458551437607;5701.6864072476;5626.12795016772;5663.122216056518;5672.546196304296;5680.517156041731;5736.196932429463;5062.190049592066;5128;5155.149400348947;5179.766910489037;5238.869028274305;5225;5277.12927366984;5278.076336641092;5279.234510995903;5283.365996080456;5066.062778385992;5090.796368145288;5096.770645320969;5102.158143906269;5140.434552199255;5198.376194856603;5216.660917040418;5216.679396362814;5226.320578324831;5252.080885844981;5075.695458272516;5082.771275292621;5083.440821509631;5083.949160508385;5097.311862898536;5493.395726470085;5536.141898005815;5562.721863906829;5562.9443705562835;5577.442255774431;6025.789097381615;6034.30605480371;6036.305824830157;6040.848978775566;6072.9696351518405;5897.852553686149;5958.880822383571;5972.193753843219;6025.487833534111;6084.513238940918;5645.237892884449;5689.630174038674;5691.77232910679;5701.942980570224;5705.942940570582;6142.355052719489;6159.19930409044;6163.96918015407;6169.136320915076;6169.259688837368;5757.453041961007;5934.258217722785;6004.519638428916;6021.458068773832;6076.8009713327;6165.938340616536;6178.505719542426;6179.412955769285;6180.598261113013;6181.289151747606;6139.201903752483;6142.539309551801;6151.630902145886;6152.415520525543;6162.291336496361;5813.273340832396;5844.094165404369;5879.941200588025;5946.108083787466;6020.247469066367;4641.187792136363;4671.509491503343;4674.509176536482;4698.647601429838;4708.741019243975;4128.339465685476;4140.544540100586;4157.106222162189;4158.688098392572;4172.186423647359;5669.943300567024;5695.430456954271;5714.2571465710025;5744.253247077937;5746.683932383759;6104.542159338067;6122.184701511125;6128.228138398679;6129.695011270001;6131.140501974693;5770.422957704196;5778.797742079007;5792.594518383673;5793.073108302651;5797.768089276466;5107.591392688576;5182.041322355376;5208.84373468789;5231.790728370823;5241.266222728821;6348.682565871688;6366.968165159237;6371.808845734636;6375.936240637627;6378.712957916905;6065.636061836304;6118.847028824315;6125.418085281891;6125.418085281891;6136.969315153396;6082;6166.506679465721;6172.845678858064;6174.783882564088;6340.112384266298;5942.989691752326;5986.132010858489;6020.277566692025;6028.758849645965;6032.125341825498;6158.445739883432;6163.445289923929;6167.475764560063;6169.6915154241215;6200.100985357189;5773.16289138081;5990.071538911476;6042.75828966854;6045;6049.274087109399;5927.347991720993;5937.435943585352;5958.463738263577;6033.366496517802;6058.969705151446;5973.641581505123;5982.880342393215;5986.790462333797;5988.550858685703;5998.940010600013;5814.563907707024;5961.821145365646;6037.63774173551;6075.19246580469;6077.301110372364;5930.495907847709;5940.851478713067;5941.494972927349;5959.463648271503;5973 13:30:48 INFO - PROCESS | 30583 | |1;ext.html;602.1900543768633;630.2279707358487;641.9069234960931;656.120798130505;668.8762578922899;33767.32465350695;46706.532934670686;47628.52371476289;47689;47708;49896;50429.74785126069;50463.74768126154;50496.74751626246;50498.24252636213;8389.95805020974;9286.535673216345;9437.716868493922;9446.527673616327;9449.102335278138;10972.122230221563;11271.774564508705;11276.32342059475;11641.592544260953;11652.24260423074;11361.318320900731;11487.540498380096;11488.942555287254;11502.884971150306;11503;11286.548538058469;11361.715957101056;11373.488193031333;11378;11382.089432845352;11052.723681908017;11059.557617695282;11071.833922491169;11131.72170695731;11143.498542565603;46534;46562.76718616385;46835.531644683455;46871.29693054607;46944.295835562494;3863.5750067492554;4055.067334513049;4175.728577642474;4431.113777244532;4664.043871006435;34862;35164.47253291203;36711.26577468462;36761.448578271345;37633;4750.786214620316;4807.759612019385;4835.162653084552;4940.086084074458;4961.107000739866;405852;408100;409675;410401;411548;69350.65324673445;69466.65266673634;69646;69690;69732;39818.40272395917;40578;40699.59300407017;42914.78542607329;74106.25893741101;18825.529361766065;19037.61924761497;19084.904575477034;19097.522561935784;19100.426987190407;11588.88411115895;12809.61571152867;13058.412371443308;13167.934160329329;13458.05793594439;21476.57046859054;21504;21689.891550542463;21785.782142178694;21808.23671171533;7535.660895259726;7573.810654733676;7633.274838890296;7636;7649.464537482323;1078.800421921947;1088.689723428819;1124.6738445850613;1140.3955903371227;1232.3037483821613;34605.480917786255;35293.82353088218;35467.64532354695;35815.641843581754;35975;1159.9478023488964;1243.5647523366931;1259.395490164726;1260.7667581497453;1275.9043071769654;18515.166817493246;18671.15979780913;18768.71846922297;18869.43391698251;18887.622247554973;549227;553747;557824;557984;565157;65663;66416.66791666011;66480;66513.66743166253;66575.33424665788;1325.827642406481;1413.3357322058616;1420.5170242117729;1465.0770014890763;1473.4916453823414;34964;36359.27281454409;36575.817120914224;36718.8164059178;36879.44680829736;56511;57256.42743572678;57275.71362143163;57285;57311.42688573061;423354;425929;426956;428511;431021;30795.846020769754;31529;32106.83946580252;32148.678513214567;33689;55567.722161388934;55628.443715563946;56131.43868561262;56267.437325627856;56977.71511142418;45868.77065614651;45986.540134598225;46575.76712116418;47346;47835.5216447845;46604.30093548532;46683.53316466792;46721;47372.2894156581;47631.76184119057;44775;44937.32594011158;45991;46096.769516152206;46584;38413.615863841005;40576.79711601423;41127.58872411238;41546;41854.79072604617;30389.392212156075;30495;30558.236044099074;30779.692203077684;30978.225544361572 13:30:48 INFO - PROCESS | 30583 | |2;jquery.html;392.88606304171793;408.74453466583367;419.64749610327317;421.1303657946341;433.61841579410117;15672.686546269068;20621.175152993863;20812.167513299468;20878;21137.47156321093;20051.09770060347;20358.98205089747;20417.387478375636;20435.897820510912;20564.48588785281;5805.5065319447895;5807.593468457209;5986.341502434729;6014.939850601503;6022.187004754368;5864.794732184374;5886.941130588703;5935.614185077978;5955.34491205967;5960.195373624549;5652.378238393773;5850.590458667895;5852.853678658046;5856.47291743743;5858.8242352729485;5655.179998900177;5875.853103672421;5890.087036509348;5918.082697181943;5921.052631578927;5320.361556613192;5323.387810401776;5326.227696983916;5326.946730532683;5330.067238233293;23491.882540587358;23847.165349212868;24111.035558577634;24555.263342099766;24678.25965221046;2603.7526434988645;2668.346255167477;2671.238696971354;2746.5742809864305;3035.2715348316465;15092.924535377362;15264.923675381662;15334.616634584114;15556.922215388964;15691.635585538705;2052.5176583502866;2114.7145135406677;2138.9893050534647;2167.642339014061;2195.4621117826077;52287.47712522902;53084.51943067349;54754.67182178032;70601.29398705998;83413.58293208494;10891.346519208873;11046.281991670516;11207.439628018567;11234.943825280821;11456.828147577793;15402.768958465633;15423.228838558252;15424.845751542565;15439;15458.768118478232;8150.673973041012;8440.78898027542;8449.95775021121;8630.921134858143;8665.003524594753;8331.16688331162;8342.749717508485;8386.580670966427;8434;8615.913840861636;6805.2173999989645;6925.445964322842;6966.79099627012;6972.372486476242;7010.614416207158;1979.356709069558;1994.5312851479891;1995.5909038647042;1997.4407165993546;2025.8278046366224;1009;1052.2423854824515;1081.978360432787;1101.9173561982884;1127.7575321305958;20368.28710995108;20950;21061.052252648667;21313.563767341137;21363.14547418117;1078.9730256743487;1087.483445363446;1089.1776708584969;1109.4286442482128;1142.8057230270874;11260.549578016951;11868.525258989544;11996.700082497833;12130.33283169434;12148;558127;566521;570669;576394;576430;82984.58507707423;83988;84840.57579712186;85744.57127714447;87011;1072.7693545887516;1090.9345439273668;1101.9283746556448;1104.1056744037355;1105.4141305108305;16909.830901690824;18264.634707306046;18473.72289415633;18541.44375668732;18776.906115469334;44593;44881;45321.77339113283;46029.309560357295;46084.769576151906;63597.36402636099;63612.68193659002;63816.32775238962;64697.67651161714;65272;7835.647395867086;8146.796330091558;8893.555322233733;8930.598123084606;8974.685885993958;12577.496900124259;13253.07228493996;13389.598312050653;13963.511277105252;14137;11717.296962182296;12109.939450302692;12183.817242741188;12347.506099755909;12666.113372063866;11244.55021799119;11299.661010169379;11528.365939873052;11715.297082175097;12121.333326666765;6686.7993960181275;9065.818683626423;11904.404779761151;12294.139410241198;12354.814677780021;7528.360089392244;9028.954855225682;9035.27717782589;9323.487208203343;9368;11333.829992550283;11854.644360668848;11920.344381059125;12027.579034733742;12334.81497777516 13:30:48 INFO - PROCESS | 30583 | |3;mootools.html;1436.0450300550135;1554.9689006219871;1593.2670971353177;1777.3601503458754;1877.5963167918894;8554.52950087745;8935.597898094586;9248.306377021716;9250.491222982733;9250.953745231265;9327.533623318825;9429.104235097655;9508.334416590842;9773.7556561086;9781.902180978188;2455.2634209737053;2523.1295203154973;2523.936901577466;2524;2525.7095434025136;2371.6442533619925;2451.4974430241846;2452.681151450309;2456.066694656028;2458.8770561471943;2422.2248880358293;2459.8770061496944;2468.419921318489;2471.7281099079087;2472.4066224106173;2323.546908352872;2327;2332.0671731307443;2358.8348815582917;2368;2384.3800611840875;2385.0579021286667;2389.7371289158177;2416.9154079607306;2434.1480481831395;8875;9706;9821.165200957927;9827;9827.656032038916;5615.0454422748235;5689.971550142222;5744.971275143639;5761.769529218826;5764.077747560412;3681.171736359298;3684.2263124743836;3730.309892669865;3750.8499660013567;3762.698984081267;1244.9128561000734;1251.3993283224104;1259.3010878962173;1293.0948336164722;1297.578287056701;13546.254955977516;13810.171389716648;13817.378217980215;13835.169889806542;13867.514636987657;4716.599089077398;4760.281585772508;4935.087008903364;4943.505649435027;5058.620603454756;11469.082473402108;11476.368799716096;11541.422928853524;11556.017738492323;11576.131790115774;5718.142278658152;5721.256236689287;5728;5733.942660573424;5736.254286942671;4415.337699345124;4612.792424340845;4617.387271013404;5178.766955487012;5237.711925844039;4472.44094488189;4477.306017567283;4512.300593408027;4546.1135078659345;4606.470255920545;1360.326638314021;1375.18863870317;1396.629893078335;1398.6433459467974;1405.0726520496628;1071.9571217151383;1102.0192029094112;1103.5199688135688;1104.3539529375246;1116.3580940958982;6686.13080299558;6856.760013399607;7035.437165026786;7067.469939754539;7184.281571842878;481.23483660978513;494.0588179518024;494.5301963135036;495.07915277583663;505.25727181043806;4815;4856.83001094967;4867.780949857265;4937.728424936591;5031.547160755549;11400.144989125849;12004.099692522921;12407.193532420364;12407.813882791765;12476.313802740937;11358.148138889615;11491.138164637685;12021.939890300493;12032.639020829389;12051.156419050581;9131.086891310815;9279.489628070385;9298.907010929805;9303.53482325881;9346.672866449642;6635.933640663725;7016.6842492089;7025.086738723933;7083.929160708327;7132.215456299699;11092.889071109508;11485.425728713364;11524.308541487537;11553.30680159193;11581.305121692725;10689.679309620724;11011.61459348919;11526.193166478266;11824.1131915105;11872.940635296769;9228.169464748205;9681;9695.127438530566;9728;9808.460534670661;9579.90420095818;9752.073553012453;9761;9763.902360976299;9764.365316254421;7757.224277572198;7761.534307941542;8512.74461766148;8658.826823463622;8704.08607096271;8243.05204901444;8282.254597086292;8320.209580089882;8323.625436855235;8419.452735572413;7847.529148251123;7885.960570197112;7953.6023198840985;7967.800804979922;8016.83966320682;5665.433456654301;5766.452187042224;5793.913091303718;5820.388859169896;6045.063015232646;5824.5340372770925;5996.4603185713495;6069.241344831896;6139.84650383744;6190.535709821691 13:30:48 INFO - PROCESS | 30583 | |4;prototype.html;347.32792047388307;351.83463772027153;356.0511237551924;362.4472679164273;364.345998931917;5345.839624811257;5407.188921661743;5433.179884738617;5441.537469315108;5507.586930980177;5365.880477211499;5366;5384.1923711443305;5398.946010539893;5430.239766432693;3907.5310962684516;4067.430559721634;4103.363978583325;4281.079567892903;4290.97854510727;4265.040365917659;4274.187904298189;4274.914501709964;4283.593058659422;4295.742255464666;4272.978635106821;4278.507971583276;4279.593438623326;4289;4292.656587472995;4059.9048194515694;4078.8572399966006;4105.91788164235;4208.684348673831;4297.828086876537;3821.73247872649;3831.3678243089857;3837.175007373428;3839.616038396166;3863.1694185749916;5198.532132108091;5249.1338929076655;5258.605604579672;5279.86800329991;5298.91372268684;4751.596114330286;4775.785089670973;4806.399200099988;4860.198067318888;4929.8028078876805;5489.451054894518;5515.586331025149;5522.254495643077;5557.777688892439;5598.944010559883;4147.419361289422;4151.045259590311;4171.791410429497;4174.519930208035;4177.12280421112;5542.418046105182;5797.536197104221;5798.188253644493;5818.679972601505;5839.591228614041;4276.636485898671;4277.422547956048;4280.474520033195;4283.7001409901;4287.828486860553;4349.369341445473;4354.10740798142;4383.364412160283;4396.142752163361;4399.560043995575;4635.281531362644;4890.193118135468;4890.853274401774;4953.356063711766;4954.355933728664;5670.829875103754;5672.886542269214;5689.943100569024;5694.145878118233;5698.202251684767;1447.7104579084225;1465.172177719585;1467.9210780076635;1472.9263536823116;1474.5107441484179;943.7687766497252;951.4196340232453;962.5716556132594;965.7054598347431;973.9318247722591;4908.730019848943;4918.409790825124;4928.310036594879;4928.605711543068;4956.339626225183;5130.743462826844;5141.920196758722;5141.974290128525;5168.328117344721;5176.404713457925;4596.230451276283;4833.468318484964;4844.297576851337;4851.830185943546;4870.613399434323;2735.7401046900513;2739.5342791725457;2746.4757059831986;2747.9450410991667;2760.6196901549224;5333.43998880112;5348.5558899097805;5370;5370.704611246419;5371.58278774553;5266.7366631668265;5273.705937917019;5557.5553955683445;5653;5833.533317334603;5844.1233814927255;6019.819405417845;6030.638161710312;6031.969840150771;6035.6076855004285;5826.41735826414;5827.94172058274;5831.067029275296;5869.972754767984;5880.970595146997;5625.8593535161945;5756.625819321731;5810.634500892203;5813.1979086483325;5816.970915145397;5986;6024.096385542204;6042.305134909541;6048.36492168316;6058.697065146637;4149.190907772955;4159.251334759772;4160.958390416057;4167.354060120686;4171.748475457412;5622.24099746529;5838.766449342149;5851.297844258716;5854.912176317273;5870.295564532113;5702.372738998624;5716.828495145152;5732;5736.6558006519745;5736.885262294647;5572.832815015394;5673.319201695823;5716.771329146954;5740.856478588069;5753.539716822561;5589.80435684749;5617.32592088952;5641.435856414326;5659.934124044777;5662.85842853932;5707.857303567444;5741.540676745767;5772.2207501986695;5783.768649253982;5792.131180322816;5423.5932305076485;5594.216809646734;5613.803516876889;5633.577481688972;5636.2954630671165 13:30:48 INFO - PROCESS | 30583 | |5;yui.html;822.782282222311;826.7685048186509;845.2561745663819;892.544802150903;935.1069728409369;15925.362985480582;17031.914840425798;17125.14374281287;17144.485665430027;17152.914235428838;16762;16936.49190524283;16945.237464314105;16965.15174241289;16968.83031169691;698.8637215742932;833.3291700181352;893.2318206342541;899.995500022499;902.4044130873625;908.1554154636186;910.6038873090226;910.9453432794021;911.1071150272703;911.6034524981621;953.9761505962337;956.2302346610975;957.033396269769;957.2581249531634;958.0276019839868;759.6999185321795;778.1634742651672;919.6873063158491;943.1841457139593;952.3000594562991;695.0894328429723;697.8394969157122;698.0959657243882;698.3261152987341;698.518022564434;16545.91727041357;16562.83437165625;16596.50210493687;16662.333506659717;16674.33302667904;15664.060156390653;15723.13522756248;15914.283857226337;16115.435959741353;16163.838361616468;14318.284085795669;14463.40902500724;14469.565913022627;14525.273736313247;14641.780373294408;4711.269753188261;4737.1946769049;4740.383750112498;4826.686265392738;4926.285688575136;84375;85341.14658853394;86471;87145;87533;12640.747185056247;12648.367581620882;12908.031897607718;12918.547850825176;13116.672083197996;23781;23864.522709546058;23892.88053559721;23901.08791296692;23916;9119.81760364789;9168.358214925025;9182.449053056704;9432.905670943202;9508.334416590911;4914.189158788831;4952.777125029383;5106.617003724736;5132.153194722829;5293.841184764463;3706.1105334719473;3845.8461661533784;3849.9037524062123;3851.5378154621626;3855.2289542091694;637.2257706886155;646.7800947677812;647.3494138390981;652.7323797243203;658.7661380210052;704.4012589299055;723.5188599581325;723.8443734596982;725.9510008038334;732.3006528765123;10005.549750261256;10318.48407579633;10552.47237638115;10619.787604247871;10911.399873007062;588.5821067042448;646.1470858466779;690.9792706218822;704.8836941904631;709.9716011359591;4999.076279353122;5055.646104772631;5110.48895110486;5130.640855140105;5144.588432925357;130713;131002;131218;133301;139709;112262;113836.43081784538;115158.42420787843;116059;119558.40220799015;65600.6719966397;97256.51371743096;100084.4995775031;101579;101685.99999999852;9519.333646644945;9700.5149742514;9834.803303933739;9863.802723945624;9971;50402.479876006786;51738.482615173365;52997.735011324694;53447.465525345804;53550.73224633852;80971;81402;81629.59185204274;81669.18330816616;84860.57569712112;12851.871481285067;12856.871431285568;12871.549495767604;12907.612771616867;13324;13904.58286251414;13909.860901390857;13994.790078149039;14007.579772606838;14062.578122656336;12188.20776649515;12777.616671499869;13060.477580897037;13331.933340333624;13884.09753366028;13219.603411897659;13391.196528208338;13460;13551.59345219645;13830.792538111735;12621.432035558606;12766.61700148997;12969.481220751064;13601.86398136006;13818.309084545532;10176.49117544105;10548.683539493828;10618.946905265424;10744.247902646739;10772.407517586607;9060.411073280216;10204.38773673582;10230;10271.486425678835;10323 13:30:48 INFO - PROCESS | 30583 | __end_tp_report 13:30:48 INFO - PROCESS | 30583 | __start_cc_report 13:30:48 INFO - PROCESS | 30583 | _x_x_mozilla_cycle_collect,1073 13:30:48 INFO - PROCESS | 30583 | __end_cc_report 13:30:48 INFO - PROCESS | 30583 | __startTimestamp1470083448389__endTimestamp 13:30:48 INFO - PROCESS | 30583 | 13:30:48 INFO - PROCESS | 30583 | ------- Summary: start ------- 13:30:48 INFO - PROCESS | 30583 | Number of tests: 6 13:30:48 INFO - PROCESS | 30583 | 13:30:48 INFO - PROCESS | 30583 | [#0] dojo.html Cycles:165 Average:5648.40 Median:5927.35 stddev:652.14 (11.0%) stddev-sans-first:625.23 13:30:48 INFO - PROCESS | 30583 | Values: 3200.8 3219.9 3224.2 3243.7 3264.1 5590.2 5671.4 5683.2 5699.5 5701.7 5626.1 5663.1 5672.5 5680.5 5736.2 5062.2 5128.0 5155.1 5179.8 5238.9 5225.0 5277.1 5278.1 5279.2 5283.4 5066.1 5090.8 5096.8 5102.2 5140.4 5198.4 5216.7 5216.7 5226.3 5252.1 5075.7 5082.8 5083.4 5083.9 5097.3 5493.4 5536.1 5562.7 5562.9 5577.4 6025.8 6034.3 6036.3 6040.8 6073.0 5897.9 5958.9 5972.2 6025.5 6084.5 5645.2 5689.6 5691.8 5701.9 5705.9 6142.4 6159.2 6164.0 6169.1 6169.3 5757.5 5934.3 6004.5 6021.5 6076.8 6165.9 6178.5 6179.4 6180.6 6181.3 6139.2 6142.5 6151.6 6152.4 6162.3 5813.3 5844.1 5879.9 5946.1 6020.2 4641.2 4671.5 4674.5 4698.6 4708.7 4128.3 4140.5 4157.1 4158.7 4172.2 5669.9 5695.4 5714.3 5744.3 5746.7 6104.5 6122.2 6128.2 6129.7 6131.1 5770.4 5778.8 5792.6 5793.1 5797.8 5107.6 5182.0 5208.8 5231.8 5241.3 6348.7 6367.0 6371.8 6375.9 6378.7 6065.6 6118.8 6125.4 6125.4 6137.0 6082.0 6166.5 6172.8 6174.8 6340.1 5943.0 5986.1 6020.3 6028.8 6032.1 6158.4 6163.4 6167.5 6169.7 6200.1 5773.2 5990.1 6042.8 6045.0 6049.3 5927.3 5937.4 5958.5 6033.4 6059.0 5973.6 5982.9 5986.8 5988.6 5998.9 5814.6 5961.8 6037.6 6075.2 6077.3 5930.5 5940.9 5941.5 5959.5 5973.0 13:30:48 INFO - PROCESS | 30583 | 13:30:48 INFO - PROCESS | 30583 | [#1] ext.html Cycles:180 Average:64729.20 Median:410038.00 stddev:123941.43 (30.2%) stddev-sans-first:124195.60 13:30:48 INFO - PROCESS | 30583 | Values: 602.2 630.2 641.9 656.1 668.9 33767.3 46706.5 47628.5 47689.0 47708.0 49896.0 50429.7 50463.7 50496.7 50498.2 8390.0 9286.5 9437.7 9446.5 9449.1 10972.1 11271.8 11276.3 11641.6 11652.2 11361.3 11487.5 11488.9 11502.9 11503.0 11286.5 11361.7 11373.5 11378.0 11382.1 11052.7 11059.6 11071.8 11131.7 11143.5 46534.0 46562.8 46835.5 46871.3 46944.3 3863.6 4055.1 4175.7 4431.1 4664.0 34862.0 35164.5 36711.3 36761.4 37633.0 4750.8 4807.8 4835.2 4940.1 4961.1 405852.0 408100.0 409675.0 410401.0 411548.0 69350.7 69466.7 69646.0 69690.0 69732.0 39818.4 40578.0 40699.6 42914.8 74106.3 18825.5 19037.6 19084.9 19097.5 19100.4 11588.9 12809.6 13058.4 13167.9 13458.1 21476.6 21504.0 21689.9 21785.8 21808.2 7535.7 7573.8 7633.3 7636.0 7649.5 1078.8 1088.7 1124.7 1140.4 1232.3 34605.5 35293.8 35467.6 35815.6 35975.0 1159.9 1243.6 1259.4 1260.8 1275.9 18515.2 18671.2 18768.7 18869.4 18887.6 549227.0 553747.0 557824.0 557984.0 565157.0 65663.0 66416.7 66480.0 66513.7 66575.3 1325.8 1413.3 1420.5 1465.1 1473.5 34964.0 36359.3 36575.8 36718.8 36879.4 56511.0 57256.4 57275.7 57285.0 57311.4 423354.0 425929.0 426956.0 428511.0 431021.0 30795.8 31529.0 32106.8 32148.7 33689.0 55567.7 55628.4 56131.4 56267.4 56977.7 45868.8 45986.5 46575.8 47346.0 47835.5 46604.3 46683.5 46721.0 47372.3 47631.8 44775.0 44937.3 45991.0 46096.8 46584.0 38413.6 40576.8 41127.6 41546.0 41854.8 30389.4 30495.0 30558.2 30779.7 30978.2 13:30:48 INFO - PROCESS | 30583 | 13:30:48 INFO - PROCESS | 30583 | [#2] jquery.html Cycles:180 Average:31238.81 Median:24333.15 stddev:93211.52 (383.1%) stddev-sans-first:93444.22 13:30:48 INFO - PROCESS | 30583 | Values: 392.9 408.7 419.6 421.1 433.6 15672.7 20621.2 20812.2 20878.0 21137.5 20051.1 20359.0 20417.4 20435.9 20564.5 5805.5 5807.6 5986.3 6014.9 6022.2 5864.8 5886.9 5935.6 5955.3 5960.2 5652.4 5850.6 5852.9 5856.5 5858.8 5655.2 5875.9 5890.1 5918.1 5921.1 5320.4 5323.4 5326.2 5326.9 5330.1 23491.9 23847.2 24111.0 24555.3 24678.3 2603.8 2668.3 2671.2 2746.6 3035.3 15092.9 15264.9 15334.6 15556.9 15691.6 2052.5 2114.7 2139.0 2167.6 2195.5 52287.5 53084.5 54754.7 70601.3 83413.6 10891.3 11046.3 11207.4 11234.9 11456.8 15402.8 15423.2 15424.8 15439.0 15458.8 8150.7 8440.8 8450.0 8630.9 8665.0 8331.2 8342.7 8386.6 8434.0 8615.9 6805.2 6925.4 6966.8 6972.4 7010.6 1979.4 1994.5 1995.6 1997.4 2025.8 1009.0 1052.2 1082.0 1101.9 1127.8 20368.3 20950.0 21061.1 21313.6 21363.1 1079.0 1087.5 1089.2 1109.4 1142.8 11260.5 11868.5 11996.7 12130.3 12148.0 558127.0 566521.0 570669.0 576394.0 576430.0 82984.6 83988.0 84840.6 85744.6 87011.0 1072.8 1090.9 1101.9 1104.1 1105.4 16909.8 18264.6 18473.7 18541.4 18776.9 44593.0 44881.0 45321.8 46029.3 46084.8 63597.4 63612.7 63816.3 64697.7 65272.0 7835.6 8146.8 8893.6 8930.6 8974.7 12577.5 13253.1 13389.6 13963.5 14137.0 11717.3 12109.9 12183.8 12347.5 12666.1 11244.6 11299.7 11528.4 11715.3 12121.3 6686.8 9065.8 11904.4 12294.1 12354.8 7528.4 9029.0 9035.3 9323.5 9368.0 11333.8 11854.6 11920.3 12027.6 12334.8 13:30:48 INFO - PROCESS | 30583 | 13:30:48 INFO - PROCESS | 30583 | [#3] mootools.html Cycles:180 Average:6432.81 Median:2648.12 stddev:3723.88 (140.6%) stddev-sans-first:3715.39 13:30:48 INFO - PROCESS | 30583 | Values: 1436.0 1555.0 1593.3 1777.4 1877.6 8554.5 8935.6 9248.3 9250.5 9251.0 9327.5 9429.1 9508.3 9773.8 9781.9 2455.3 2523.1 2523.9 2524.0 2525.7 2371.6 2451.5 2452.7 2456.1 2458.9 2422.2 2459.9 2468.4 2471.7 2472.4 2323.5 2327.0 2332.1 2358.8 2368.0 2384.4 2385.1 2389.7 2416.9 2434.1 8875.0 9706.0 9821.2 9827.0 9827.7 5615.0 5690.0 5745.0 5761.8 5764.1 3681.2 3684.2 3730.3 3750.8 3762.7 1244.9 1251.4 1259.3 1293.1 1297.6 13546.3 13810.2 13817.4 13835.2 13867.5 4716.6 4760.3 4935.1 4943.5 5058.6 11469.1 11476.4 11541.4 11556.0 11576.1 5718.1 5721.3 5728.0 5733.9 5736.3 4415.3 4612.8 4617.4 5178.8 5237.7 4472.4 4477.3 4512.3 4546.1 4606.5 1360.3 1375.2 1396.6 1398.6 1405.1 1072.0 1102.0 1103.5 1104.4 1116.4 6686.1 6856.8 7035.4 7067.5 7184.3 481.2 494.1 494.5 495.1 505.3 4815.0 4856.8 4867.8 4937.7 5031.5 11400.1 12004.1 12407.2 12407.8 12476.3 11358.1 11491.1 12021.9 12032.6 12051.2 9131.1 9279.5 9298.9 9303.5 9346.7 6635.9 7016.7 7025.1 7083.9 7132.2 11092.9 11485.4 11524.3 11553.3 11581.3 10689.7 11011.6 11526.2 11824.1 11872.9 9228.2 9681.0 9695.1 9728.0 9808.5 9579.9 9752.1 9761.0 9763.9 9764.4 7757.2 7761.5 8512.7 8658.8 8704.1 8243.1 8282.3 8320.2 8323.6 8419.5 7847.5 7886.0 7953.6 7967.8 8016.8 5665.4 5766.5 5793.9 5820.4 6045.1 5824.5 5996.5 6069.2 6139.8 6190.5 13:30:48 INFO - PROCESS | 30583 | 13:30:48 INFO - PROCESS | 30583 | [#4] prototype.html Cycles:180 Average:4709.02 Median:5289.39 stddev:1371.21 (25.9%) stddev-sans-first:1335.41 13:30:48 INFO - PROCESS | 30583 | Values: 347.3 351.8 356.1 362.4 364.3 5345.8 5407.2 5433.2 5441.5 5507.6 5365.9 5366.0 5384.2 5398.9 5430.2 3907.5 4067.4 4103.4 4281.1 4291.0 4265.0 4274.2 4274.9 4283.6 4295.7 4273.0 4278.5 4279.6 4289.0 4292.7 4059.9 4078.9 4105.9 4208.7 4297.8 3821.7 3831.4 3837.2 3839.6 3863.2 5198.5 5249.1 5258.6 5279.9 5298.9 4751.6 4775.8 4806.4 4860.2 4929.8 5489.5 5515.6 5522.3 5557.8 5598.9 4147.4 4151.0 4171.8 4174.5 4177.1 5542.4 5797.5 5798.2 5818.7 5839.6 4276.6 4277.4 4280.5 4283.7 4287.8 4349.4 4354.1 4383.4 4396.1 4399.6 4635.3 4890.2 4890.9 4953.4 4954.4 5670.8 5672.9 5689.9 5694.1 5698.2 1447.7 1465.2 1467.9 1472.9 1474.5 943.8 951.4 962.6 965.7 973.9 4908.7 4918.4 4928.3 4928.6 4956.3 5130.7 5141.9 5142.0 5168.3 5176.4 4596.2 4833.5 4844.3 4851.8 4870.6 2735.7 2739.5 2746.5 2747.9 2760.6 5333.4 5348.6 5370.0 5370.7 5371.6 5266.7 5273.7 5557.6 5653.0 5833.5 5844.1 6019.8 6030.6 6032.0 6035.6 5826.4 5827.9 5831.1 5870.0 5881.0 5625.9 5756.6 5810.6 5813.2 5817.0 5986.0 6024.1 6042.3 6048.4 6058.7 4149.2 4159.3 4161.0 4167.4 4171.7 5622.2 5838.8 5851.3 5854.9 5870.3 5702.4 5716.8 5732.0 5736.7 5736.9 5572.8 5673.3 5716.8 5740.9 5753.5 5589.8 5617.3 5641.4 5659.9 5662.9 5707.9 5741.5 5772.2 5783.8 5792.1 5423.6 5594.2 5613.8 5633.6 5636.3 13:30:48 INFO - PROCESS | 30583 | 13:30:48 INFO - PROCESS | 30583 | [#5] yui.html Cycles:180 Average:22854.32 Median:3853.38 stddev:34090.87 (884.7%) stddev-sans-first:34146.37 13:30:48 INFO - PROCESS | 30583 | Values: 822.8 826.8 845.3 892.5 935.1 15925.4 17031.9 17125.1 17144.5 17152.9 16762.0 16936.5 16945.2 16965.2 16968.8 698.9 833.3 893.2 900.0 902.4 908.2 910.6 910.9 911.1 911.6 954.0 956.2 957.0 957.3 958.0 759.7 778.2 919.7 943.2 952.3 695.1 697.8 698.1 698.3 698.5 16545.9 16562.8 16596.5 16662.3 16674.3 15664.1 15723.1 15914.3 16115.4 16163.8 14318.3 14463.4 14469.6 14525.3 14641.8 4711.3 4737.2 4740.4 4826.7 4926.3 84375.0 85341.1 86471.0 87145.0 87533.0 12640.7 12648.4 12908.0 12918.5 13116.7 23781.0 23864.5 23892.9 23901.1 23916.0 9119.8 9168.4 9182.4 9432.9 9508.3 4914.2 4952.8 5106.6 5132.2 5293.8 3706.1 3845.8 3849.9 3851.5 3855.2 637.2 646.8 647.3 652.7 658.8 704.4 723.5 723.8 726.0 732.3 10005.5 10318.5 10552.5 10619.8 10911.4 588.6 646.1 691.0 704.9 710.0 4999.1 5055.6 5110.5 5130.6 5144.6 130713.0 131002.0 131218.0 133301.0 139709.0 112262.0 113836.4 115158.4 116059.0 119558.4 65600.7 97256.5 100084.5 101579.0 101686.0 9519.3 9700.5 9834.8 9863.8 9971.0 50402.5 51738.5 52997.7 53447.5 53550.7 80971.0 81402.0 81629.6 81669.2 84860.6 12851.9 12856.9 12871.5 12907.6 13324.0 13904.6 13909.9 13994.8 14007.6 14062.6 12188.2 12777.6 13060.5 13331.9 13884.1 13219.6 13391.2 13460.0 13551.6 13830.8 12621.4 12766.6 12969.5 13601.9 13818.3 10176.5 10548.7 10618.9 10744.2 10772.4 9060.4 10204.4 10230.0 10271.5 10323.0 13:30:48 INFO - PROCESS | 30583 | -------- Summary: end -------- 13:30:48 INFO - PROCESS | 30583 | 13:30:49 INFO - TEST-INFO | 30583: exit 0 13:30:49 INFO - TEST-OK | dromaeo_css | took 1113497ms 13:30:49 INFO - TEST-START | kraken 13:30:49 INFO - operating with platform_type : linux_ 13:30:49 INFO - Initialising browser for kraken test... 13:30:49 INFO - TEST-INFO | started process 30787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKS0tSo/profile http://localhost:45155/getInfo.html) 13:30:53 INFO - PROCESS | 30787 | __metrics Screen width/height:1600/1200 13:30:53 INFO - PROCESS | 30787 | colorDepth:24 13:30:53 INFO - PROCESS | 30787 | Browser inner width/height: 1024/697 13:30:53 INFO - PROCESS | 30787 | __metrics 13:30:53 INFO - PROCESS | 30787 | 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" 13:30:53 INFO - PROCESS | 30787 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:30:54 INFO - TEST-INFO | 30787: exit 0 13:30:54 INFO - Browser initialized. 13:30:54 INFO - Running cycle 1/1 for kraken test... 13:30:54 INFO - TEST-INFO | started process 30875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKS0tSo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:06 INFO - PROCESS | 30875 | RSS: Main: 145448960 13:31:06 INFO - PROCESS | 30875 | 13:31:09 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45155/tests/kraken/driver.html?testName=audio-beat-detection) 13:31:09 INFO - PROCESS | 30875 | RSS: Main: 191574016 13:31:09 INFO - PROCESS | 30875 | 13:31:12 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45155/tests/kraken/driver.html?testName=audio-dft) 13:31:13 INFO - PROCESS | 30875 | RSS: Main: 180428800 13:31:13 INFO - PROCESS | 30875 | 13:31:15 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45155/tests/kraken/driver.html?testName=audio-fft) 13:31:16 INFO - PROCESS | 30875 | RSS: Main: 270376960 13:31:16 INFO - PROCESS | 30875 | 13:31:18 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45155/tests/kraken/driver.html?testName=audio-oscillator) 13:31:19 INFO - PROCESS | 30875 | RSS: Main: 175804416 13:31:19 INFO - PROCESS | 30875 | 13:31:21 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45155/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:31:21 INFO - PROCESS | 30875 | RSS: Main: 177299456 13:31:21 INFO - PROCESS | 30875 | 13:31:24 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45155/tests/kraken/driver.html?testName=imaging-darkroom) 13:31:25 INFO - PROCESS | 30875 | RSS: Main: 213221376 13:31:25 INFO - PROCESS | 30875 | 13:31:28 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45155/tests/kraken/driver.html?testName=imaging-desaturate) 13:31:29 INFO - PROCESS | 30875 | RSS: Main: 212512768 13:31:29 INFO - PROCESS | 30875 | 13:31:32 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45155/tests/kraken/driver.html?testName=json-parse-financial) 13:31:32 INFO - PROCESS | 30875 | RSS: Main: 211779584 13:31:32 INFO - PROCESS | 30875 | 13:31:34 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45155/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:31:34 INFO - PROCESS | 30875 | RSS: Main: 175378432 13:31:34 INFO - PROCESS | 30875 | 13:31:36 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45155/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:31:37 INFO - PROCESS | 30875 | RSS: Main: 181264384 13:31:37 INFO - PROCESS | 30875 | 13:31:39 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45155/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:31:39 INFO - PROCESS | 30875 | RSS: Main: 186044416 13:31:39 INFO - PROCESS | 30875 | 13:31:42 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:31:42 INFO - PROCESS | 30875 | RSS: Main: 180617216 13:31:42 INFO - PROCESS | 30875 | 13:31:45 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:31:46 INFO - PROCESS | 30875 | RSS: Main: 184619008 13:31:46 INFO - PROCESS | 30875 | 13:31:47 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:45155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45155/tests/kraken/driver.html?testName=ai-astar) 13:31:48 INFO - PROCESS | 30875 | RSS: Main: 235794432 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | __start_tp_report 13:31:48 INFO - PROCESS | 30875 | _x_x_mozilla_page_load 13:31:48 INFO - PROCESS | 30875 | _x_x_mozilla_page_load_details 13:31:48 INFO - PROCESS | 30875 | |i|pagename|runs| 13:31:48 INFO - PROCESS | 30875 | |0;ai-astar;101;112;112;110;111;110;110;110;111;112 13:31:48 INFO - PROCESS | 30875 | |1;audio-beat-detection;140;115;116;167;122;116;144;120;151;115 13:31:48 INFO - PROCESS | 30875 | |2;audio-dft;160;160;161;159;160;161;160;160;160;159 13:31:48 INFO - PROCESS | 30875 | |3;audio-fft;74;74;74;130;75;75;75;74;97;75 13:31:48 INFO - PROCESS | 30875 | |4;audio-oscillator;83;84;111;83;83;84;115;82;83;126 13:31:48 INFO - PROCESS | 30875 | |5;imaging-gaussian-blur;117;117;117;117;116;117;118;117;117;116 13:31:48 INFO - PROCESS | 30875 | |6;imaging-darkroom;146;145;145;145;146;146;146;149;145;145 13:31:48 INFO - PROCESS | 30875 | |7;imaging-desaturate;95;94;95;95;95;95;94;94;95;95 13:31:48 INFO - PROCESS | 30875 | |8;json-parse-financial;50;49;50;51;50;50;54;50;50;50 13:31:48 INFO - PROCESS | 30875 | |9;json-stringify-tinderbox;64;62;62;63;64;62;62;62;63;63 13:31:48 INFO - PROCESS | 30875 | |10;stanford-crypto-aes;72;71;72;73;73;72;78;72;73;72 13:31:48 INFO - PROCESS | 30875 | |11;stanford-crypto-ccm;118;116;115;115;114;122;116;115;194;117 13:31:48 INFO - PROCESS | 30875 | |12;stanford-crypto-pbkdf2;152;156;151;154;150;156;157;155;153;154 13:31:48 INFO - PROCESS | 30875 | |13;stanford-crypto-sha256-iterative;60;62;64;61;60;60;60;59;61;59 13:31:48 INFO - PROCESS | 30875 | __end_tp_report 13:31:48 INFO - PROCESS | 30875 | __start_cc_report 13:31:48 INFO - PROCESS | 30875 | _x_x_mozilla_cycle_collect,1623 13:31:48 INFO - PROCESS | 30875 | __end_cc_report 13:31:48 INFO - PROCESS | 30875 | __startTimestamp1470083508078__endTimestamp 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | ------- Summary: start ------- 13:31:48 INFO - PROCESS | 30875 | Number of tests: 14 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.25 (2.9%) stddev-sans-first:0.93 13:31:48 INFO - PROCESS | 30875 | Values: 101.0 112.0 112.0 110.0 111.0 110.0 110.0 110.0 111.0 112.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:131.00 stddev:18.58 (14.2%) stddev-sans-first:19.40 13:31:48 INFO - PROCESS | 30875 | Values: 140.0 115.0 116.0 167.0 122.0 116.0 144.0 120.0 151.0 115.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 13:31:48 INFO - PROCESS | 30875 | Values: 160.0 160.0 161.0 159.0 160.0 161.0 160.0 160.0 160.0 159.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:18.20 (24.3%) stddev-sans-first:19.05 13:31:48 INFO - PROCESS | 30875 | Values: 74.0 74.0 74.0 130.0 75.0 75.0 75.0 74.0 97.0 75.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:83.00 stddev:16.93 (20.4%) stddev-sans-first:17.53 13:31:48 INFO - PROCESS | 30875 | Values: 83.0 84.0 111.0 83.0 83.0 84.0 115.0 82.0 83.0 126.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:31:48 INFO - PROCESS | 30875 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 116.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 13:31:48 INFO - PROCESS | 30875 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 146.0 149.0 145.0 145.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:31:48 INFO - PROCESS | 30875 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.00 stddev:1.35 (2.7%) stddev-sans-first:1.42 13:31:48 INFO - PROCESS | 30875 | Values: 50.0 49.0 50.0 51.0 50.0 50.0 54.0 50.0 50.0 50.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 13:31:48 INFO - PROCESS | 30875 | Values: 64.0 62.0 62.0 63.0 64.0 62.0 62.0 62.0 63.0 63.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:72.50 stddev:1.93 (2.7%) stddev-sans-first:2.03 13:31:48 INFO - PROCESS | 30875 | Values: 72.0 71.0 72.0 73.0 73.0 72.0 78.0 72.0 73.0 72.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:116.50 stddev:24.63 (21.1%) stddev-sans-first:26.02 13:31:48 INFO - PROCESS | 30875 | Values: 118.0 116.0 115.0 115.0 114.0 122.0 116.0 115.0 194.0 117.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:154.50 stddev:2.30 (1.5%) stddev-sans-first:2.35 13:31:48 INFO - PROCESS | 30875 | Values: 152.0 156.0 151.0 154.0 150.0 156.0 157.0 155.0 153.0 154.0 13:31:48 INFO - PROCESS | 30875 | 13:31:48 INFO - PROCESS | 30875 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:60.50 stddev:1.51 (2.5%) stddev-sans-first:1.58 13:31:48 INFO - PROCESS | 30875 | Values: 60.0 62.0 64.0 61.0 60.0 60.0 60.0 59.0 61.0 59.0 13:31:48 INFO - PROCESS | 30875 | -------- Summary: end -------- 13:31:48 INFO - PROCESS | 30875 | 13:31:49 INFO - TEST-INFO | 30875: exit 0 13:31:49 INFO - TEST-OK | kraken | took 59869ms 13:31:49 INFO - SUITE-END | took 1173s 13:31:49 INFO - Completed test suite (00:19:33) 13:31:49 INFO - javascript benchmark 13:31:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3200.775945683802, 3219.8712051517928, 3224.1617179533328, 3243.675632436758, 3264.102371847742, 5590.245316882219, 5671.376148623648, 5683.232763576921, 5699.458551437607, 5701.6864072476, 5626.12795016772, 5663.122216056518, 5672.546196304296, 5680.517156041731, 5736.196932429463, 5062.190049592066, 5128.0, 5155.149400348947, 5179.766910489037, 5238.869028274305, 5225.0, 5277.12927366984, 5278.076336641092, 5279.234510995903, 5283.365996080456, 5066.062778385992, 5090.796368145288, 5096.770645320969, 5102.158143906269, 5140.434552199255, 5198.376194856603, 5216.660917040418, 5216.679396362814, 5226.320578324831, 5252.080885844981, 5075.695458272516, 5082.771275292621, 5083.440821509631, 5083.949160508385, 5097.311862898536, 5493.395726470085, 5536.141898005815, 5562.721863906829, 5562.9443705562835, 5577.442255774431, 6025.789097381615, 6034.30605480371, 6036.305824830157, 6040.848978775566, 6072.9696351518405, 5897.852553686149, 5958.880822383571, 5972.193753843219, 6025.487833534111, 6084.513238940918, 5645.237892884449, 5689.630174038674, 5691.77232910679, 5701.942980570224, 5705.942940570582, 6142.355052719489, 6159.19930409044, 6163.96918015407, 6169.136320915076, 6169.259688837368, 5757.453041961007, 5934.258217722785, 6004.519638428916, 6021.458068773832, 6076.8009713327, 6165.938340616536, 6178.505719542426, 6179.412955769285, 6180.598261113013, 6181.289151747606, 6139.201903752483, 6142.539309551801, 6151.630902145886, 6152.415520525543, 6162.291336496361, 5813.273340832396, 5844.094165404369, 5879.941200588025, 5946.108083787466, 6020.247469066367, 4641.187792136363, 4671.509491503343, 4674.509176536482, 4698.647601429838, 4708.741019243975, 4128.339465685476, 4140.544540100586, 4157.106222162189, 4158.688098392572, 4172.186423647359, 5669.943300567024, 5695.430456954271, 5714.2571465710025, 5744.253247077937, 5746.683932383759, 6104.542159338067, 6122.184701511125, 6128.228138398679, 6129.695011270001, 6131.140501974693, 5770.422957704196, 5778.797742079007, 5792.594518383673, 5793.073108302651, 5797.768089276466, 5107.591392688576, 5182.041322355376, 5208.84373468789, 5231.790728370823, 5241.266222728821, 6348.682565871688, 6366.968165159237, 6371.808845734636, 6375.936240637627, 6378.712957916905, 6065.636061836304, 6118.847028824315, 6125.418085281891, 6125.418085281891, 6136.969315153396, 6082.0, 6166.506679465721, 6172.845678858064, 6174.783882564088, 6340.112384266298, 5942.989691752326, 5986.132010858489, 6020.277566692025, 6028.758849645965, 6032.125341825498, 6158.445739883432, 6163.445289923929, 6167.475764560063, 6169.6915154241215, 6200.100985357189, 5773.16289138081, 5990.071538911476, 6042.75828966854, 6045.0, 6049.274087109399, 5927.347991720993, 5937.435943585352, 5958.463738263577, 6033.366496517802, 6058.969705151446, 5973.641581505123, 5982.880342393215, 5986.790462333797, 5988.550858685703, 5998.940010600013, 5814.563907707024, 5961.821145365646, 6037.63774173551, 6075.19246580469, 6077.301110372364, 5930.495907847709, 5940.851478713067, 5941.494972927349, 5959.463648271503, 5973.0], "value": 5603.271262118302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.1900543768633, 630.2279707358487, 641.9069234960931, 656.120798130505, 668.8762578922899, 33767.32465350695, 46706.532934670686, 47628.52371476289, 47689.0, 47708.0, 49896.0, 50429.74785126069, 50463.74768126154, 50496.74751626246, 50498.24252636213, 8389.95805020974, 9286.535673216345, 9437.716868493922, 9446.527673616327, 9449.102335278138, 10972.122230221563, 11271.774564508705, 11276.32342059475, 11641.592544260953, 11652.24260423074, 11361.318320900731, 11487.540498380096, 11488.942555287254, 11502.884971150306, 11503.0, 11286.548538058469, 11361.715957101056, 11373.488193031333, 11378.0, 11382.089432845352, 11052.723681908017, 11059.557617695282, 11071.833922491169, 11131.72170695731, 11143.498542565603, 46534.0, 46562.76718616385, 46835.531644683455, 46871.29693054607, 46944.295835562494, 3863.5750067492554, 4055.067334513049, 4175.728577642474, 4431.113777244532, 4664.043871006435, 34862.0, 35164.47253291203, 36711.26577468462, 36761.448578271345, 37633.0, 4750.786214620316, 4807.759612019385, 4835.162653084552, 4940.086084074458, 4961.107000739866, 405852.0, 408100.0, 409675.0, 410401.0, 411548.0, 69350.65324673445, 69466.65266673634, 69646.0, 69690.0, 69732.0, 39818.40272395917, 40578.0, 40699.59300407017, 42914.78542607329, 74106.25893741101, 18825.529361766065, 19037.61924761497, 19084.904575477034, 19097.522561935784, 19100.426987190407, 11588.88411115895, 12809.61571152867, 13058.412371443308, 13167.934160329329, 13458.05793594439, 21476.57046859054, 21504.0, 21689.891550542463, 21785.782142178694, 21808.23671171533, 7535.660895259726, 7573.810654733676, 7633.274838890296, 7636.0, 7649.464537482323, 1078.800421921947, 1088.689723428819, 1124.6738445850613, 1140.3955903371227, 1232.3037483821613, 34605.480917786255, 35293.82353088218, 35467.64532354695, 35815.641843581754, 35975.0, 1159.9478023488964, 1243.5647523366931, 1259.395490164726, 1260.7667581497453, 1275.9043071769654, 18515.166817493246, 18671.15979780913, 18768.71846922297, 18869.43391698251, 18887.622247554973, 549227.0, 553747.0, 557824.0, 557984.0, 565157.0, 65663.0, 66416.66791666011, 66480.0, 66513.66743166253, 66575.33424665788, 1325.827642406481, 1413.3357322058616, 1420.5170242117729, 1465.0770014890763, 1473.4916453823414, 34964.0, 36359.27281454409, 36575.817120914224, 36718.8164059178, 36879.44680829736, 56511.0, 57256.42743572678, 57275.71362143163, 57285.0, 57311.42688573061, 423354.0, 425929.0, 426956.0, 428511.0, 431021.0, 30795.846020769754, 31529.0, 32106.83946580252, 32148.678513214567, 33689.0, 55567.722161388934, 55628.443715563946, 56131.43868561262, 56267.437325627856, 56977.71511142418, 45868.77065614651, 45986.540134598225, 46575.76712116418, 47346.0, 47835.5216447845, 46604.30093548532, 46683.53316466792, 46721.0, 47372.2894156581, 47631.76184119057, 44775.0, 44937.32594011158, 45991.0, 46096.769516152206, 46584.0, 38413.615863841005, 40576.79711601423, 41127.58872411238, 41546.0, 41854.79072604617, 30389.392212156075, 30495.0, 30558.236044099074, 30779.692203077684, 30978.225544361572], "value": 22396.89221696598, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.88606304171793, 408.74453466583367, 419.64749610327317, 421.1303657946341, 433.61841579410117, 15672.686546269068, 20621.175152993863, 20812.167513299468, 20878.0, 21137.47156321093, 20051.09770060347, 20358.98205089747, 20417.387478375636, 20435.897820510912, 20564.48588785281, 5805.5065319447895, 5807.593468457209, 5986.341502434729, 6014.939850601503, 6022.187004754368, 5864.794732184374, 5886.941130588703, 5935.614185077978, 5955.34491205967, 5960.195373624549, 5652.378238393773, 5850.590458667895, 5852.853678658046, 5856.47291743743, 5858.8242352729485, 5655.179998900177, 5875.853103672421, 5890.087036509348, 5918.082697181943, 5921.052631578927, 5320.361556613192, 5323.387810401776, 5326.227696983916, 5326.946730532683, 5330.067238233293, 23491.882540587358, 23847.165349212868, 24111.035558577634, 24555.263342099766, 24678.25965221046, 2603.7526434988645, 2668.346255167477, 2671.238696971354, 2746.5742809864305, 3035.2715348316465, 15092.924535377362, 15264.923675381662, 15334.616634584114, 15556.922215388964, 15691.635585538705, 2052.5176583502866, 2114.7145135406677, 2138.9893050534647, 2167.642339014061, 2195.4621117826077, 52287.47712522902, 53084.51943067349, 54754.67182178032, 70601.29398705998, 83413.58293208494, 10891.346519208873, 11046.281991670516, 11207.439628018567, 11234.943825280821, 11456.828147577793, 15402.768958465633, 15423.228838558252, 15424.845751542565, 15439.0, 15458.768118478232, 8150.673973041012, 8440.78898027542, 8449.95775021121, 8630.921134858143, 8665.003524594753, 8331.16688331162, 8342.749717508485, 8386.580670966427, 8434.0, 8615.913840861636, 6805.2173999989645, 6925.445964322842, 6966.79099627012, 6972.372486476242, 7010.614416207158, 1979.356709069558, 1994.5312851479891, 1995.5909038647042, 1997.4407165993546, 2025.8278046366224, 1009.0, 1052.2423854824515, 1081.978360432787, 1101.9173561982884, 1127.7575321305958, 20368.28710995108, 20950.0, 21061.052252648667, 21313.563767341137, 21363.14547418117, 1078.9730256743487, 1087.483445363446, 1089.1776708584969, 1109.4286442482128, 1142.8057230270874, 11260.549578016951, 11868.525258989544, 11996.700082497833, 12130.33283169434, 12148.0, 558127.0, 566521.0, 570669.0, 576394.0, 576430.0, 82984.58507707423, 83988.0, 84840.57579712186, 85744.57127714447, 87011.0, 1072.7693545887516, 1090.9345439273668, 1101.9283746556448, 1104.1056744037355, 1105.4141305108305, 16909.830901690824, 18264.634707306046, 18473.72289415633, 18541.44375668732, 18776.906115469334, 44593.0, 44881.0, 45321.77339113283, 46029.309560357295, 46084.769576151906, 63597.36402636099, 63612.68193659002, 63816.32775238962, 64697.67651161714, 65272.0, 7835.647395867086, 8146.796330091558, 8893.555322233733, 8930.598123084606, 8974.685885993958, 12577.496900124259, 13253.07228493996, 13389.598312050653, 13963.511277105252, 14137.0, 11717.296962182296, 12109.939450302692, 12183.817242741188, 12347.506099755909, 12666.113372063866, 11244.55021799119, 11299.661010169379, 11528.365939873052, 11715.297082175097, 12121.333326666765, 6686.7993960181275, 9065.818683626423, 11904.404779761151, 12294.139410241198, 12354.814677780021, 7528.360089392244, 9028.954855225682, 9035.27717782589, 9323.487208203343, 9368.0, 11333.829992550283, 11854.644360668848, 11920.344381059125, 12027.579034733742, 12334.81497777516], "value": 9728.669403045524, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.0450300550135, 1554.9689006219871, 1593.2670971353177, 1777.3601503458754, 1877.5963167918894, 8554.52950087745, 8935.597898094586, 9248.306377021716, 9250.491222982733, 9250.953745231265, 9327.533623318825, 9429.104235097655, 9508.334416590842, 9773.7556561086, 9781.902180978188, 2455.2634209737053, 2523.1295203154973, 2523.936901577466, 2524.0, 2525.7095434025136, 2371.6442533619925, 2451.4974430241846, 2452.681151450309, 2456.066694656028, 2458.8770561471943, 2422.2248880358293, 2459.8770061496944, 2468.419921318489, 2471.7281099079087, 2472.4066224106173, 2323.546908352872, 2327.0, 2332.0671731307443, 2358.8348815582917, 2368.0, 2384.3800611840875, 2385.0579021286667, 2389.7371289158177, 2416.9154079607306, 2434.1480481831395, 8875.0, 9706.0, 9821.165200957927, 9827.0, 9827.656032038916, 5615.0454422748235, 5689.971550142222, 5744.971275143639, 5761.769529218826, 5764.077747560412, 3681.171736359298, 3684.2263124743836, 3730.309892669865, 3750.8499660013567, 3762.698984081267, 1244.9128561000734, 1251.3993283224104, 1259.3010878962173, 1293.0948336164722, 1297.578287056701, 13546.254955977516, 13810.171389716648, 13817.378217980215, 13835.169889806542, 13867.514636987657, 4716.599089077398, 4760.281585772508, 4935.087008903364, 4943.505649435027, 5058.620603454756, 11469.082473402108, 11476.368799716096, 11541.422928853524, 11556.017738492323, 11576.131790115774, 5718.142278658152, 5721.256236689287, 5728.0, 5733.942660573424, 5736.254286942671, 4415.337699345124, 4612.792424340845, 4617.387271013404, 5178.766955487012, 5237.711925844039, 4472.44094488189, 4477.306017567283, 4512.300593408027, 4546.1135078659345, 4606.470255920545, 1360.326638314021, 1375.18863870317, 1396.629893078335, 1398.6433459467974, 1405.0726520496628, 1071.9571217151383, 1102.0192029094112, 1103.5199688135688, 1104.3539529375246, 1116.3580940958982, 6686.13080299558, 6856.760013399607, 7035.437165026786, 7067.469939754539, 7184.281571842878, 481.23483660978513, 494.0588179518024, 494.5301963135036, 495.07915277583663, 505.25727181043806, 4815.0, 4856.83001094967, 4867.780949857265, 4937.728424936591, 5031.547160755549, 11400.144989125849, 12004.099692522921, 12407.193532420364, 12407.813882791765, 12476.313802740937, 11358.148138889615, 11491.138164637685, 12021.939890300493, 12032.639020829389, 12051.156419050581, 9131.086891310815, 9279.489628070385, 9298.907010929805, 9303.53482325881, 9346.672866449642, 6635.933640663725, 7016.6842492089, 7025.086738723933, 7083.929160708327, 7132.215456299699, 11092.889071109508, 11485.425728713364, 11524.308541487537, 11553.30680159193, 11581.305121692725, 10689.679309620724, 11011.61459348919, 11526.193166478266, 11824.1131915105, 11872.940635296769, 9228.169464748205, 9681.0, 9695.127438530566, 9728.0, 9808.460534670661, 9579.90420095818, 9752.073553012453, 9761.0, 9763.902360976299, 9764.365316254421, 7757.224277572198, 7761.534307941542, 8512.74461766148, 8658.826823463622, 8704.08607096271, 8243.05204901444, 8282.254597086292, 8320.209580089882, 8323.625436855235, 8419.452735572413, 7847.529148251123, 7885.960570197112, 7953.6023198840985, 7967.800804979922, 8016.83966320682, 5665.433456654301, 5766.452187042224, 5793.913091303718, 5820.388859169896, 6045.063015232646, 5824.5340372770925, 5996.4603185713495, 6069.241344831896, 6139.84650383744, 6190.535709821691], "value": 5021.431350985259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.32792047388307, 351.83463772027153, 356.0511237551924, 362.4472679164273, 364.345998931917, 5345.839624811257, 5407.188921661743, 5433.179884738617, 5441.537469315108, 5507.586930980177, 5365.880477211499, 5366.0, 5384.1923711443305, 5398.946010539893, 5430.239766432693, 3907.5310962684516, 4067.430559721634, 4103.363978583325, 4281.079567892903, 4290.97854510727, 4265.040365917659, 4274.187904298189, 4274.914501709964, 4283.593058659422, 4295.742255464666, 4272.978635106821, 4278.507971583276, 4279.593438623326, 4289.0, 4292.656587472995, 4059.9048194515694, 4078.8572399966006, 4105.91788164235, 4208.684348673831, 4297.828086876537, 3821.73247872649, 3831.3678243089857, 3837.175007373428, 3839.616038396166, 3863.1694185749916, 5198.532132108091, 5249.1338929076655, 5258.605604579672, 5279.86800329991, 5298.91372268684, 4751.596114330286, 4775.785089670973, 4806.399200099988, 4860.198067318888, 4929.8028078876805, 5489.451054894518, 5515.586331025149, 5522.254495643077, 5557.777688892439, 5598.944010559883, 4147.419361289422, 4151.045259590311, 4171.791410429497, 4174.519930208035, 4177.12280421112, 5542.418046105182, 5797.536197104221, 5798.188253644493, 5818.679972601505, 5839.591228614041, 4276.636485898671, 4277.422547956048, 4280.474520033195, 4283.7001409901, 4287.828486860553, 4349.369341445473, 4354.10740798142, 4383.364412160283, 4396.142752163361, 4399.560043995575, 4635.281531362644, 4890.193118135468, 4890.853274401774, 4953.356063711766, 4954.355933728664, 5670.829875103754, 5672.886542269214, 5689.943100569024, 5694.145878118233, 5698.202251684767, 1447.7104579084225, 1465.172177719585, 1467.9210780076635, 1472.9263536823116, 1474.5107441484179, 943.7687766497252, 951.4196340232453, 962.5716556132594, 965.7054598347431, 973.9318247722591, 4908.730019848943, 4918.409790825124, 4928.310036594879, 4928.605711543068, 4956.339626225183, 5130.743462826844, 5141.920196758722, 5141.974290128525, 5168.328117344721, 5176.404713457925, 4596.230451276283, 4833.468318484964, 4844.297576851337, 4851.830185943546, 4870.613399434323, 2735.7401046900513, 2739.5342791725457, 2746.4757059831986, 2747.9450410991667, 2760.6196901549224, 5333.43998880112, 5348.5558899097805, 5370.0, 5370.704611246419, 5371.58278774553, 5266.7366631668265, 5273.705937917019, 5557.5553955683445, 5653.0, 5833.533317334603, 5844.1233814927255, 6019.819405417845, 6030.638161710312, 6031.969840150771, 6035.6076855004285, 5826.41735826414, 5827.94172058274, 5831.067029275296, 5869.972754767984, 5880.970595146997, 5625.8593535161945, 5756.625819321731, 5810.634500892203, 5813.1979086483325, 5816.970915145397, 5986.0, 6024.096385542204, 6042.305134909541, 6048.36492168316, 6058.697065146637, 4149.190907772955, 4159.251334759772, 4160.958390416057, 4167.354060120686, 4171.748475457412, 5622.24099746529, 5838.766449342149, 5851.297844258716, 5854.912176317273, 5870.295564532113, 5702.372738998624, 5716.828495145152, 5732.0, 5736.6558006519745, 5736.885262294647, 5572.832815015394, 5673.319201695823, 5716.771329146954, 5740.856478588069, 5753.539716822561, 5589.80435684749, 5617.32592088952, 5641.435856414326, 5659.934124044777, 5662.85842853932, 5707.857303567444, 5741.540676745767, 5772.2207501986695, 5783.768649253982, 5792.131180322816, 5423.5932305076485, 5594.216809646734, 5613.803516876889, 5633.577481688972, 5636.2954630671165], "value": 4278.268220143141, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.782282222311, 826.7685048186509, 845.2561745663819, 892.544802150903, 935.1069728409369, 15925.362985480582, 17031.914840425798, 17125.14374281287, 17144.485665430027, 17152.914235428838, 16762.0, 16936.49190524283, 16945.237464314105, 16965.15174241289, 16968.83031169691, 698.8637215742932, 833.3291700181352, 893.2318206342541, 899.995500022499, 902.4044130873625, 908.1554154636186, 910.6038873090226, 910.9453432794021, 911.1071150272703, 911.6034524981621, 953.9761505962337, 956.2302346610975, 957.033396269769, 957.2581249531634, 958.0276019839868, 759.6999185321795, 778.1634742651672, 919.6873063158491, 943.1841457139593, 952.3000594562991, 695.0894328429723, 697.8394969157122, 698.0959657243882, 698.3261152987341, 698.518022564434, 16545.91727041357, 16562.83437165625, 16596.50210493687, 16662.333506659717, 16674.33302667904, 15664.060156390653, 15723.13522756248, 15914.283857226337, 16115.435959741353, 16163.838361616468, 14318.284085795669, 14463.40902500724, 14469.565913022627, 14525.273736313247, 14641.780373294408, 4711.269753188261, 4737.1946769049, 4740.383750112498, 4826.686265392738, 4926.285688575136, 84375.0, 85341.14658853394, 86471.0, 87145.0, 87533.0, 12640.747185056247, 12648.367581620882, 12908.031897607718, 12918.547850825176, 13116.672083197996, 23781.0, 23864.522709546058, 23892.88053559721, 23901.08791296692, 23916.0, 9119.81760364789, 9168.358214925025, 9182.449053056704, 9432.905670943202, 9508.334416590911, 4914.189158788831, 4952.777125029383, 5106.617003724736, 5132.153194722829, 5293.841184764463, 3706.1105334719473, 3845.8461661533784, 3849.9037524062123, 3851.5378154621626, 3855.2289542091694, 637.2257706886155, 646.7800947677812, 647.3494138390981, 652.7323797243203, 658.7661380210052, 704.4012589299055, 723.5188599581325, 723.8443734596982, 725.9510008038334, 732.3006528765123, 10005.549750261256, 10318.48407579633, 10552.47237638115, 10619.787604247871, 10911.399873007062, 588.5821067042448, 646.1470858466779, 690.9792706218822, 704.8836941904631, 709.9716011359591, 4999.076279353122, 5055.646104772631, 5110.48895110486, 5130.640855140105, 5144.588432925357, 130713.0, 131002.0, 131218.0, 133301.0, 139709.0, 112262.0, 113836.43081784538, 115158.42420787843, 116059.0, 119558.40220799015, 65600.6719966397, 97256.51371743096, 100084.4995775031, 101579.0, 101685.99999999852, 9519.333646644945, 9700.5149742514, 9834.803303933739, 9863.802723945624, 9971.0, 50402.479876006786, 51738.482615173365, 52997.735011324694, 53447.465525345804, 53550.73224633852, 80971.0, 81402.0, 81629.59185204274, 81669.18330816616, 84860.57569712112, 12851.871481285067, 12856.871431285568, 12871.549495767604, 12907.612771616867, 13324.0, 13904.58286251414, 13909.860901390857, 13994.790078149039, 14007.579772606838, 14062.578122656336, 12188.20776649515, 12777.616671499869, 13060.477580897037, 13331.933340333624, 13884.09753366028, 13219.603411897659, 13391.196528208338, 13460.0, 13551.59345219645, 13830.792538111735, 12621.432035558606, 12766.61700148997, 12969.481220751064, 13601.86398136006, 13818.309084545532, 10176.49117544105, 10548.683539493828, 10618.946905265424, 10744.247902646739, 10772.407517586607, 9060.411073280216, 10204.38773673582, 10230.0, 10271.486425678835, 10323.0], "value": 8065.271686289802, "unit": "score"}], "name": "dromaeo_css", "value": 7719.227962318384, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 116.0, 167.0, 122.0, 116.0, 144.0, 120.0, 151.0, 115.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 160.0, 161.0, 160.0, 160.0, 160.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 130.0, 75.0, 75.0, 75.0, 74.0, 97.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 111.0, 83.0, 83.0, 84.0, 115.0, 82.0, 83.0, 126.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 149.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 51.0, 50.0, 50.0, 54.0, 50.0, 50.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 63.0, 64.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 73.0, 73.0, 72.0, 78.0, 72.0, 73.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 115.0, 115.0, 114.0, 122.0, 116.0, 115.0, 194.0, 117.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 156.0, 151.0, 154.0, 150.0, 156.0, 157.0, 155.0, 153.0, 154.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 64.0, 61.0, 60.0, 60.0, 60.0, 59.0, 61.0, 59.0], "value": 60.6, "unit": "score"}], "name": "kraken", "value": 1458.1, "alertThreshold": 2.0}]} 13:31:49 INFO - Return code: 0 13:31:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:31:49 INFO - # TBPL SUCCESS # 13:31:49 INFO - Running post-action listener: _resource_record_post_action 13:31:49 INFO - [mozharness: 2016-08-01 20:31:49.406671Z] Finished run-tests step (success) 13:31:49 INFO - Running post-run listener: _resource_record_post_run 13:31:49 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 508260352; Read time: 0; Write time: 464308 13:31:49 INFO - TinderboxPrint: CPU usage
13.0% 13:31:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:31:49 INFO - TinderboxPrint: I/O write bytes / time
508,260,352 / 464,308 13:31:49 INFO - TinderboxPrint: CPU idle
8,266.6 (87.0%) 13:31:49 INFO - TinderboxPrint: CPU user
1,184.2 (12.5%) 13:31:49 INFO - TinderboxPrint: Swap in / out
0 / 0 13:31:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 253595648; Read time: 0; Write time: 266680 13:31:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 254648320; Read time: 0; Write time: 197628 13:31:50 INFO - Running post-run listener: _upload_blobber_files 13:31:50 INFO - Blob upload gear active. 13:31:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:31:50 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 13:31:50 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:31:50 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:31:50 INFO - (blobuploader) - INFO - Open directory for files ... 13:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:53 INFO - (blobuploader) - INFO - Done attempting. 13:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:54 INFO - (blobuploader) - INFO - Done attempting. 13:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:31:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:31:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:31:55 INFO - (blobuploader) - INFO - Done attempting. 13:31:55 INFO - (blobuploader) - INFO - Iteration through files over. 13:31:55 INFO - Return code: 0 13:31:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:31:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:31:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f6e3d8c172a847a42c1677d6aadaaa93fc9721b1dcfda34a60af2216c4efddcc2e38f79b1db5a33da38ce3f2b0e36898d6785a17ac5438dff89a88e7a9393cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3b5171fd70ff7635efbd2eb764ecc2ecb25994df6624b86c3a779c31efc7d92349fa9eb05f92598422362a6440f80ea4f1888735388d147d5878c754293fdc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2af3e403c0f79cfe6ccc09250c5d3430e917f3eca4773a9520c8720b632884e06e5f29d6f5133c42bebbf976b5527b64457b9c1ba7447e44861df02c7ca92ffa"} 13:31:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:31:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:31:55 INFO - Contents: 13:31:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f6e3d8c172a847a42c1677d6aadaaa93fc9721b1dcfda34a60af2216c4efddcc2e38f79b1db5a33da38ce3f2b0e36898d6785a17ac5438dff89a88e7a9393cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3b5171fd70ff7635efbd2eb764ecc2ecb25994df6624b86c3a779c31efc7d92349fa9eb05f92598422362a6440f80ea4f1888735388d147d5878c754293fdc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2af3e403c0f79cfe6ccc09250c5d3430e917f3eca4773a9520c8720b632884e06e5f29d6f5133c42bebbf976b5527b64457b9c1ba7447e44861df02c7ca92ffa"} 13:31:55 INFO - Running post-run listener: copy_logs_to_upload_dir 13:31:55 INFO - Copying logs to upload dir... 13:31:55 INFO - mkdir: /builds/slave/test/build/upload/logs 13:31:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.225775 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-08-01 13:31:53.836149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 13:31:53.839318) ========= 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=32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f6e3d8c172a847a42c1677d6aadaaa93fc9721b1dcfda34a60af2216c4efddcc2e38f79b1db5a33da38ce3f2b0e36898d6785a17ac5438dff89a88e7a9393cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3b5171fd70ff7635efbd2eb764ecc2ecb25994df6624b86c3a779c31efc7d92349fa9eb05f92598422362a6440f80ea4f1888735388d147d5878c754293fdc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2af3e403c0f79cfe6ccc09250c5d3430e917f3eca4773a9520c8720b632884e06e5f29d6f5133c42bebbf976b5527b64457b9c1ba7447e44861df02c7ca92ffa"} build_url:https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f6e3d8c172a847a42c1677d6aadaaa93fc9721b1dcfda34a60af2216c4efddcc2e38f79b1db5a33da38ce3f2b0e36898d6785a17ac5438dff89a88e7a9393cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3b5171fd70ff7635efbd2eb764ecc2ecb25994df6624b86c3a779c31efc7d92349fa9eb05f92598422362a6440f80ea4f1888735388d147d5878c754293fdc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2af3e403c0f79cfe6ccc09250c5d3430e917f3eca4773a9520c8720b632884e06e5f29d6f5133c42bebbf976b5527b64457b9c1ba7447e44861df02c7ca92ffa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 13:31:53.864649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:31:53.864983) ========= 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=32c5991c409366f7fec8a718000001d2-1470082285.461796-1073601742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:31:53.946528) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 13:31:53.946826) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 13:31:53.947102) ========= ========= Total master_lag: 0.17 =========