builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1470101256.37 results: success (0) buildid: 20160801154050 builduid: 461f74804c2040b79178b08abedad621 revision: 53406372ffafd9cafd7ea4b8802a5fa7876bcfe5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:36.372282) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:36.372776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:36.373087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:36.387996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:36.388307) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 18:27:36-- 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% 226M=0s 2016-08-01 18:27:36 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153781 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:36.558012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:36.558384) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020842 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:36.608378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:36.608762) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 53406372ffafd9cafd7ea4b8802a5fa7876bcfe5 --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 53406372ffafd9cafd7ea4b8802a5fa7876bcfe5 --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=97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 18:27:37,061 truncating revision to first 12 chars 2016-08-01 18:27:37,061 Setting DEBUG logging. 2016-08-01 18:27:37,061 attempt 1/10 2016-08-01 18:27:37,061 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/53406372ffaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 18:27:37,619 unpacking tar archive at: mozilla-aurora-53406372ffaf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.894121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:37.518545) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:37.520045) ========= script_repo_revision: 53406372ffafd9cafd7ea4b8802a5fa7876bcfe5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:37.521303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:37.522006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 18:27:37.534042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-01 18:27:37.534406) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:27:38 INFO - MultiFileLogger online at 20160801 18:27:38 in /builds/slave/test 18:27:38 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 18:27:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:27:38 INFO - {'append_to_log': False, 18:27:38 INFO - 'base_work_dir': '/builds/slave/test', 18:27:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:27:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:27:38 INFO - 'branch': 'Mozilla-Aurora', 18:27:38 INFO - 'buildbot_json_path': 'buildprops.json', 18:27:38 INFO - 'config_files': ('talos/linux_config.py',), 18:27:38 INFO - 'default_actions': ('clobber', 18:27:38 INFO - 'read-buildbot-config', 18:27:38 INFO - 'download-and-extract', 18:27:38 INFO - 'populate-webroot', 18:27:38 INFO - 'create-virtualenv', 18:27:38 INFO - 'install', 18:27:38 INFO - 'run-tests'), 18:27:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:27:38 INFO - 'download_minidump_stackwalk': True, 18:27:38 INFO - 'download_symbols': 'ondemand', 18:27:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:27:38 INFO - 'tooltool.py': '/tools/tooltool.py', 18:27:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:27:38 INFO - '/tools/misc-python/virtualenv.py')}, 18:27:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:27:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:27:38 INFO - 'installer_path': 'installer.exe', 18:27:38 INFO - 'log_level': 'info', 18:27:38 INFO - 'log_name': 'talos', 18:27:38 INFO - 'log_to_console': True, 18:27:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:27:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:27:38 INFO - 'opt_config_files': (), 18:27:38 INFO - 'pip_index': False, 18:27:38 INFO - 'sps_profile': False, 18:27:38 INFO - 'sps_profile_interval': 0, 18:27:38 INFO - 'suite': 'dromaeojs', 18:27:38 INFO - 'system_bits': '32', 18:27:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:27:38 INFO - 'title': 'talos-linux64-ix-068', 18:27:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:27:38 INFO - 'use_talos_json': True, 18:27:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:27:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:27:38 INFO - 'work_dir': 'build'} 18:27:38 INFO - [mozharness: 2016-08-02 01:27:38.082230Z] Running clobber step. 18:27:38 INFO - Running pre-action listener: _resource_record_pre_action 18:27:38 INFO - Running main action method: clobber 18:27:38 INFO - rmtree: /builds/slave/test/build 18:27:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:27:39 INFO - Running post-action listener: _resource_record_post_action 18:27:39 INFO - [mozharness: 2016-08-02 01:27:39.062830Z] Finished clobber step (success) 18:27:39 INFO - [mozharness: 2016-08-02 01:27:39.062931Z] Running read-buildbot-config step. 18:27:39 INFO - Running pre-action listener: _resource_record_pre_action 18:27:39 INFO - Running main action method: read_buildbot_config 18:27:39 INFO - Using buildbot properties: 18:27:39 INFO - { 18:27:39 INFO - "project": "", 18:27:39 INFO - "product": "firefox", 18:27:39 INFO - "script_repo_revision": "production", 18:27:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:27:39 INFO - "repository": "", 18:27:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:27:39 INFO - "buildid": "20160801154050", 18:27:39 INFO - "pgo_build": "True", 18:27:39 INFO - "basedir": "/builds/slave/test", 18:27:39 INFO - "buildnumber": 408, 18:27:39 INFO - "slavename": "talos-linux64-ix-068", 18:27:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:27:39 INFO - "platform": "ubuntu64_hw", 18:27:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:27:39 INFO - "branch": "mozilla-aurora", 18:27:39 INFO - "repo_path": "releases/mozilla-aurora", 18:27:39 INFO - "revision": "53406372ffafd9cafd7ea4b8802a5fa7876bcfe5", 18:27:39 INFO - "stage_platform": "linux64-pgo", 18:27:39 INFO - "builduid": "461f74804c2040b79178b08abedad621", 18:27:39 INFO - "slavebuilddir": "test" 18:27:39 INFO - } 18:27:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 18:27:39 INFO - Running post-action listener: _resource_record_post_action 18:27:39 INFO - [mozharness: 2016-08-02 01:27:39.065734Z] Finished read-buildbot-config step (success) 18:27:39 INFO - [mozharness: 2016-08-02 01:27:39.065837Z] Running download-and-extract step. 18:27:39 INFO - Running pre-action listener: _resource_record_pre_action 18:27:39 INFO - Running main action method: download_and_extract 18:27:39 INFO - mkdir: /builds/slave/test/build/tests 18:27: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')]} 18:27:39 INFO - https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:27:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:27:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:27:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:39 INFO - Downloaded 1361 bytes. 18:27:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:27:39 INFO - Using the following test package requirements: 18:27:39 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 18:27:39 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:27:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:27:39 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:27:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:27:39 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:27:39 INFO - u'jsshell-linux-x86_64.zip'], 18:27:39 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:27:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:27:39 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 18:27:39 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:27:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:27:39 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:27:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:27:39 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:27:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:27:39 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:27:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:27:39 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:27: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')]} 18:27:39 INFO - https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:27:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:27:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:27:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:40 INFO - Downloaded 21766004 bytes. 18:27:40 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'] 18:27:40 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 18:27:41 INFO - Return code: 0 18:27:41 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 18:27:41 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')]} 18:27:41 INFO - https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:27:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:27:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:27:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:42 INFO - Downloaded 21766004 bytes. 18:27:42 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'] 18:27:42 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 18:27:44 INFO - Return code: 0 18:27:44 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')]} 18:27:44 INFO - https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:27:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:27:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:27:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:45 INFO - Downloaded 14413723 bytes. 18:27:45 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'] 18:27:45 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 18:27:45 INFO - Return code: 0 18:27: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')]} 18:27:45 INFO - https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:27:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:27:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:27:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9ArChShSSqgBAYB7_YytQ/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 18:27:46 INFO - Downloaded 63767402 bytes. 18:27:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:27:46 INFO - mkdir: /builds/slave/test/properties 18:27:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:27:46 INFO - Writing to file /builds/slave/test/properties/build_url 18:27:46 INFO - Contents: 18:27:46 INFO - build_url:https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:27:47 INFO - Running post-action listener: _resource_record_post_action 18:27:47 INFO - Running post-action listener: set_extra_try_arguments 18:27:47 INFO - [mozharness: 2016-08-02 01:27:47.564696Z] Finished download-and-extract step (success) 18:27:47 INFO - [mozharness: 2016-08-02 01:27:47.564927Z] Running populate-webroot step. 18:27:47 INFO - Running pre-action listener: _resource_record_pre_action 18:27:47 INFO - Running main action method: populate_webroot 18:27:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:27:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:27:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:27:47 INFO - '--tppagecycles', 18:27:47 INFO - '7'], 18:27:47 INFO - 'tests': ['tsvgm']}}, 18:27:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:27:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:27:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:27:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:27:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:47 INFO - 'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:27:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:27:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:47 INFO - 'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['damp', 'tps']}, 18:27:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:47 INFO - 'tests': ['damp', 'tps']}, 18:27:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['dromaeo_dom']}, 18:27:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:27:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['basic_compositor_video']}, 18:27:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:27:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['a11yr', 18:27:47 INFO - 'ts_paint', 18:27:47 INFO - 'tpaint', 18:27:47 INFO - 'sessionrestore', 18:27:47 INFO - 'sessionrestore_no_auto_restore', 18:27:47 INFO - 'tabpaint']}, 18:27:47 INFO - 'other-e10s': {'tests': ['a11yr', 18:27:47 INFO - 'ts_paint', 18:27:47 INFO - 'tpaint', 18:27:47 INFO - 'sessionrestore', 18:27:47 INFO - 'sessionrestore_no_auto_restore', 18:27:47 INFO - 'tabpaint']}, 18:27:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:27:47 INFO - 'ts_paint', 18:27:47 INFO - 'tpaint', 18:27:47 INFO - 'sessionrestore', 18:27:47 INFO - 'sessionrestore_no_auto_restore', 18:27:47 INFO - 'tabpaint']}, 18:27:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:27:47 INFO - 'ts_paint', 18:27:47 INFO - 'tpaint', 18:27:47 INFO - 'sessionrestore', 18:27:47 INFO - 'sessionrestore_no_auto_restore', 18:27:47 INFO - 'tabpaint']}, 18:27:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['a11yr', 18:27:47 INFO - 'ts_paint', 18:27:47 INFO - 'tpaint', 18:27:47 INFO - 'sessionrestore', 18:27:47 INFO - 'sessionrestore_no_auto_restore', 18:27:47 INFO - 'tabpaint']}, 18:27:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['a11yr', 18:27:47 INFO - 'ts_paint', 18:27:47 INFO - 'tpaint', 18:27:47 INFO - 'sessionrestore', 18:27:47 INFO - 'sessionrestore_no_auto_restore', 18:27:47 INFO - 'tabpaint']}, 18:27:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['tsvgx', 18:27:47 INFO - 'tsvgr_opacity', 18:27:47 INFO - 'tart', 18:27:47 INFO - 'tscrollx', 18:27:47 INFO - 'cart']}, 18:27:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:27:47 INFO - 'tsvgr_opacity', 18:27:47 INFO - 'tart', 18:27:47 INFO - 'tscrollx', 18:27:47 INFO - 'cart']}, 18:27:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:47 INFO - 'talos_options': ['--disable-e10s'], 18:27:47 INFO - 'tests': ['tp5o']}, 18:27:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:47 INFO - 'tests': ['tp5o']}, 18:27:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:47 INFO - 'talos_options': ['--disable-e10s', 18:27:47 INFO - '--xperf_path', 18:27:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:27:47 INFO - 'tests': ['tp5n']}, 18:27:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:47 INFO - 'talos_options': ['--xperf_path', 18:27:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:27:47 INFO - 'tests': ['tp5n']}}, 18:27:47 INFO - 'talos.zip': {'path': '', 18:27:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:27:47 INFO - Running post-action listener: _resource_record_post_action 18:27:47 INFO - [mozharness: 2016-08-02 01:27:47.583668Z] Finished populate-webroot step (success) 18:27:47 INFO - [mozharness: 2016-08-02 01:27:47.583757Z] Running create-virtualenv step. 18:27:47 INFO - Running pre-action listener: _resource_record_pre_action 18:27:47 INFO - Running main action method: create_virtualenv 18:27:47 INFO - Creating virtualenv /builds/slave/test/build/venv 18:27:47 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 18:27:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:27:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:27:47 INFO - Using real prefix '/usr' 18:27:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:27:48 INFO - Installing distribute.............................................................................................................................................................................................done. 18:27:50 INFO - Installing pip.................done. 18:27:50 INFO - Return code: 0 18:27:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:27:50 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')]} 18:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:50 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')]} 18:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:50 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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:27:50 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 18:27:50 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 18:27:50 INFO - Using env: {'DISPLAY': ':0', 18:27:50 INFO - 'HOME': '/home/cltbld', 18:27:50 INFO - 'LANG': 'en_US.UTF-8', 18:27:50 INFO - 'LANGUAGE': 'en_US:en', 18:27:50 INFO - 'LOGNAME': 'cltbld', 18:27:50 INFO - 'MAIL': '/var/mail/cltbld', 18:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:50 INFO - 'MOZ_NO_REMOTE': '1', 18:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:50 INFO - 'NO_EM_RESTART': '1', 18:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:50 INFO - 'PWD': '/builds/slave/test', 18:27:50 INFO - 'SHELL': '/bin/bash', 18:27:50 INFO - 'SHLVL': '1', 18:27:50 INFO - 'TERM': 'linux', 18:27:50 INFO - 'TMOUT': '86400', 18:27:50 INFO - 'USER': 'cltbld', 18:27:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:50 INFO - '_': '/tools/buildbot/bin/python'} 18:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:50 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 18:27:50 INFO - Cleaning up... 18:27:50 INFO - Return code: 0 18:27:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:27:50 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')]} 18:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:50 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')]} 18:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:50 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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:27:50 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 18:27:50 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 18:27:50 INFO - Using env: {'DISPLAY': ':0', 18:27:50 INFO - 'HOME': '/home/cltbld', 18:27:50 INFO - 'LANG': 'en_US.UTF-8', 18:27:50 INFO - 'LANGUAGE': 'en_US:en', 18:27:50 INFO - 'LOGNAME': 'cltbld', 18:27:50 INFO - 'MAIL': '/var/mail/cltbld', 18:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:50 INFO - 'MOZ_NO_REMOTE': '1', 18:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:50 INFO - 'NO_EM_RESTART': '1', 18:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:50 INFO - 'PWD': '/builds/slave/test', 18:27:50 INFO - 'SHELL': '/bin/bash', 18:27:50 INFO - 'SHLVL': '1', 18:27:50 INFO - 'TERM': 'linux', 18:27:50 INFO - 'TMOUT': '86400', 18:27:50 INFO - 'USER': 'cltbld', 18:27:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:50 INFO - '_': '/tools/buildbot/bin/python'} 18:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:50 INFO - Downloading/unpacking psutil>=3.1.1 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:27:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:52 INFO - Installing collected packages: psutil 18:27:52 INFO - Running setup.py install for psutil 18:27:52 INFO - building 'psutil._psutil_linux' extension 18:27:52 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 18:27:52 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 18:27:52 INFO - building 'psutil._psutil_posix' extension 18:27:52 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 18:27:53 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 18:27:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:53 INFO - Successfully installed psutil 18:27:53 INFO - Cleaning up... 18:27:53 INFO - Return code: 0 18:27:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:53 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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:27:53 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 18:27:53 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 18:27:53 INFO - Using env: {'DISPLAY': ':0', 18:27:53 INFO - 'HOME': '/home/cltbld', 18:27:53 INFO - 'LANG': 'en_US.UTF-8', 18:27:53 INFO - 'LANGUAGE': 'en_US:en', 18:27:53 INFO - 'LOGNAME': 'cltbld', 18:27:53 INFO - 'MAIL': '/var/mail/cltbld', 18:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:53 INFO - 'MOZ_NO_REMOTE': '1', 18:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:53 INFO - 'NO_EM_RESTART': '1', 18:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:53 INFO - 'PWD': '/builds/slave/test', 18:27:53 INFO - 'SHELL': '/bin/bash', 18:27:53 INFO - 'SHLVL': '1', 18:27:53 INFO - 'TERM': 'linux', 18:27:53 INFO - 'TMOUT': '86400', 18:27:53 INFO - 'USER': 'cltbld', 18:27:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:53 INFO - '_': '/tools/buildbot/bin/python'} 18:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:27:55 INFO - Installing collected packages: mozsystemmonitor 18:27:55 INFO - Running setup.py install for mozsystemmonitor 18:27:55 INFO - Successfully installed mozsystemmonitor 18:27:55 INFO - Cleaning up... 18:27:55 INFO - Return code: 0 18:27:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:27:55 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')]} 18:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:55 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')]} 18:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:55 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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:27:55 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 18:27:55 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 18:27:55 INFO - Using env: {'DISPLAY': ':0', 18:27:55 INFO - 'HOME': '/home/cltbld', 18:27:55 INFO - 'LANG': 'en_US.UTF-8', 18:27:55 INFO - 'LANGUAGE': 'en_US:en', 18:27:55 INFO - 'LOGNAME': 'cltbld', 18:27:55 INFO - 'MAIL': '/var/mail/cltbld', 18:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:55 INFO - 'MOZ_NO_REMOTE': '1', 18:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:55 INFO - 'NO_EM_RESTART': '1', 18:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:55 INFO - 'PWD': '/builds/slave/test', 18:27:55 INFO - 'SHELL': '/bin/bash', 18:27:55 INFO - 'SHLVL': '1', 18:27:55 INFO - 'TERM': 'linux', 18:27:55 INFO - 'TMOUT': '86400', 18:27:55 INFO - 'USER': 'cltbld', 18:27:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:55 INFO - '_': '/tools/buildbot/bin/python'} 18:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:55 INFO - Downloading/unpacking jsonschema==2.5.1 18:27:55 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 18:27:55 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 18:27:55 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 18:27:55 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 18:27:55 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 18:27:55 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 18:27:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:27:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:27:57 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 18:27:57 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 18:27:57 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 18:27:57 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 18:27:57 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 18:27:57 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 18:27:57 INFO - Downloading functools32-3.2.3-2.tar.gz 18:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:27:57 INFO - warning: no files found matching '*.txt' 18:27:57 INFO - no previously-included directories found matching 'build' 18:27:57 INFO - no previously-included directories found matching 'dist' 18:27:57 INFO - no previously-included directories found matching '.git*' 18:27:57 INFO - Installing collected packages: jsonschema, functools32 18:27:57 INFO - Running setup.py install for functools32 18:27:57 INFO - warning: no files found matching '*.txt' 18:27:57 INFO - no previously-included directories found matching 'build' 18:27:57 INFO - no previously-included directories found matching 'dist' 18:27:57 INFO - no previously-included directories found matching '.git*' 18:27:58 INFO - Successfully installed jsonschema functools32 18:27:58 INFO - Cleaning up... 18:27:58 INFO - Return code: 0 18:27:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:27: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')]} 18:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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')]} 18:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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', '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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:27: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 functools32==3.2.3-2 18:27:58 INFO - Using env: {'DISPLAY': ':0', 18:27:58 INFO - 'HOME': '/home/cltbld', 18:27:58 INFO - 'LANG': 'en_US.UTF-8', 18:27:58 INFO - 'LANGUAGE': 'en_US:en', 18:27:58 INFO - 'LOGNAME': 'cltbld', 18:27:58 INFO - 'MAIL': '/var/mail/cltbld', 18:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:58 INFO - 'MOZ_NO_REMOTE': '1', 18:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:58 INFO - 'NO_EM_RESTART': '1', 18:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:58 INFO - 'PWD': '/builds/slave/test', 18:27:58 INFO - 'SHELL': '/bin/bash', 18:27:58 INFO - 'SHLVL': '1', 18:27:58 INFO - 'TERM': 'linux', 18:27:58 INFO - 'TMOUT': '86400', 18:27:58 INFO - 'USER': 'cltbld', 18:27:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:58 INFO - '_': '/tools/buildbot/bin/python'} 18:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:27:58 INFO - Cleaning up... 18:27:58 INFO - Return code: 0 18:27:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:27: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')]} 18:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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')]} 18:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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', '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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:27: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 blobuploader==1.2.4 18:27:58 INFO - Using env: {'DISPLAY': ':0', 18:27:58 INFO - 'HOME': '/home/cltbld', 18:27:58 INFO - 'LANG': 'en_US.UTF-8', 18:27:58 INFO - 'LANGUAGE': 'en_US:en', 18:27:58 INFO - 'LOGNAME': 'cltbld', 18:27:58 INFO - 'MAIL': '/var/mail/cltbld', 18:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:58 INFO - 'MOZ_NO_REMOTE': '1', 18:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:58 INFO - 'NO_EM_RESTART': '1', 18:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:58 INFO - 'PWD': '/builds/slave/test', 18:27:58 INFO - 'SHELL': '/bin/bash', 18:27:58 INFO - 'SHLVL': '1', 18:27:58 INFO - 'TERM': 'linux', 18:27:58 INFO - 'TMOUT': '86400', 18:27:58 INFO - 'USER': 'cltbld', 18:27:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:58 INFO - '_': '/tools/buildbot/bin/python'} 18:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:28:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:28:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:01 INFO - Downloading docopt-0.6.1.tar.gz 18:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:28:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:28:01 INFO - Running setup.py install for blobuploader 18:28:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:28:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:28:01 INFO - Running setup.py install for requests 18:28:01 INFO - Running setup.py install for docopt 18:28:01 INFO - Successfully installed blobuploader requests docopt 18:28:01 INFO - Cleaning up... 18:28:01 INFO - Return code: 0 18:28:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:28:01 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')]} 18:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:01 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')]} 18:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:01 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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:28:01 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 18:28:01 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 18:28:01 INFO - Using env: {'DISPLAY': ':0', 18:28:01 INFO - 'HOME': '/home/cltbld', 18:28:01 INFO - 'LANG': 'en_US.UTF-8', 18:28:01 INFO - 'LANGUAGE': 'en_US:en', 18:28:01 INFO - 'LOGNAME': 'cltbld', 18:28:01 INFO - 'MAIL': '/var/mail/cltbld', 18:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:01 INFO - 'MOZ_NO_REMOTE': '1', 18:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:01 INFO - 'NO_EM_RESTART': '1', 18:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:01 INFO - 'PWD': '/builds/slave/test', 18:28:01 INFO - 'SHELL': '/bin/bash', 18:28:01 INFO - 'SHLVL': '1', 18:28:01 INFO - 'TERM': 'linux', 18:28:01 INFO - 'TMOUT': '86400', 18:28:01 INFO - 'USER': 'cltbld', 18:28:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:01 INFO - '_': '/tools/buildbot/bin/python'} 18:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:28:01 INFO - Running setup.py (path:/tmp/pip-R1FzZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:28:02 INFO - Running setup.py (path:/tmp/pip-ImkW4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:28:02 INFO - Running setup.py (path:/tmp/pip-V8QIJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:28:02 INFO - Running setup.py (path:/tmp/pip-2DQn0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:28:02 INFO - Running setup.py (path:/tmp/pip-XPYS6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:28:02 INFO - Running setup.py (path:/tmp/pip-CDY1h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:28:02 INFO - Running setup.py (path:/tmp/pip-Oiufbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:28:02 INFO - Running setup.py (path:/tmp/pip-HT7TEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:28:02 INFO - Running setup.py (path:/tmp/pip-u7bV81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:28:02 INFO - Running setup.py (path:/tmp/pip-nnsYls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:28:02 INFO - Running setup.py (path:/tmp/pip-uwv2BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:28:02 INFO - Running setup.py (path:/tmp/pip-PNjoTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:28:02 INFO - Running setup.py (path:/tmp/pip-7SeEDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:28:02 INFO - Running setup.py (path:/tmp/pip-QjuuIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:28:03 INFO - Running setup.py (path:/tmp/pip-XqdNKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:28:03 INFO - Running setup.py (path:/tmp/pip-wzcOre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:28:03 INFO - Running setup.py (path:/tmp/pip-yNR7fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:28:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:28:03 INFO - Running setup.py install for manifestparser 18:28:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:28:03 INFO - Running setup.py install for mozcrash 18:28:03 INFO - Running setup.py install for mozdebug 18:28:03 INFO - Running setup.py install for mozdevice 18:28:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:28:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:28:03 INFO - Running setup.py install for mozfile 18:28:03 INFO - Running setup.py install for mozhttpd 18:28:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:28:03 INFO - Running setup.py install for mozinfo 18:28:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:28:03 INFO - Running setup.py install for mozInstall 18:28:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Running setup.py install for mozleak 18:28:04 INFO - Running setup.py install for mozlog 18:28:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Running setup.py install for moznetwork 18:28:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Running setup.py install for mozprocess 18:28:04 INFO - Running setup.py install for mozprofile 18:28:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Running setup.py install for mozrunner 18:28:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:28:04 INFO - Running setup.py install for mozscreenshot 18:28:04 INFO - Running setup.py install for moztest 18:28:04 INFO - Running setup.py install for mozversion 18:28:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:28:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:28:05 INFO - Cleaning up... 18:28:05 INFO - Return code: 0 18:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:05 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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:28:05 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 18:28:05 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 18:28:05 INFO - Using env: {'DISPLAY': ':0', 18:28:05 INFO - 'HOME': '/home/cltbld', 18:28:05 INFO - 'LANG': 'en_US.UTF-8', 18:28:05 INFO - 'LANGUAGE': 'en_US:en', 18:28:05 INFO - 'LOGNAME': 'cltbld', 18:28:05 INFO - 'MAIL': '/var/mail/cltbld', 18:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:05 INFO - 'MOZ_NO_REMOTE': '1', 18:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:05 INFO - 'NO_EM_RESTART': '1', 18:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:05 INFO - 'PWD': '/builds/slave/test', 18:28:05 INFO - 'SHELL': '/bin/bash', 18:28:05 INFO - 'SHLVL': '1', 18:28:05 INFO - 'TERM': 'linux', 18:28:05 INFO - 'TMOUT': '86400', 18:28:05 INFO - 'USER': 'cltbld', 18:28:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:05 INFO - '_': '/tools/buildbot/bin/python'} 18:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:28:05 INFO - Running setup.py (path:/tmp/pip-ruYd77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:28:05 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)) 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:28:05 INFO - Running setup.py (path:/tmp/pip-69JqF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:28:05 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)) 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:28:05 INFO - Running setup.py (path:/tmp/pip-0ftjT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:28:05 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)) 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:28:05 INFO - Running setup.py (path:/tmp/pip-yjzq6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:28:05 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)) 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:28:05 INFO - Running setup.py (path:/tmp/pip-1xxBNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:28:05 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)) 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:28:05 INFO - Running setup.py (path:/tmp/pip-fFPY8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:28:05 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)) 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:28:05 INFO - Running setup.py (path:/tmp/pip-oS48k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:28:05 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)) 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:28:05 INFO - Running setup.py (path:/tmp/pip-MMIzb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:28:05 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)) 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:28:05 INFO - Running setup.py (path:/tmp/pip-Jqu4HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:28:05 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)) 18:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:28:05 INFO - Running setup.py (path:/tmp/pip-cGSlJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:28:05 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)) 18:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:28:06 INFO - Running setup.py (path:/tmp/pip-mtyFDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:28:06 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)) 18:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:28:06 INFO - Running setup.py (path:/tmp/pip-x8h4Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:28:06 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)) 18:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:28:06 INFO - Running setup.py (path:/tmp/pip-kaxwkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:28:06 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)) 18:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:28:06 INFO - Running setup.py (path:/tmp/pip-2WYsOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:28:06 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)) 18:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:28:06 INFO - Running setup.py (path:/tmp/pip-iv3zoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:28:06 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)) 18:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:28:06 INFO - Running setup.py (path:/tmp/pip-encO4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:28:06 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)) 18:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:28:06 INFO - Running setup.py (path:/tmp/pip-xIlKmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:28:06 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)) 18:28:06 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)) 18:28:06 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)) 18:28:06 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)) 18:28:06 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)) 18:28:06 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)) 18:28:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:28:06 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 18:28:06 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 18:28:06 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 18:28:06 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 18:28:06 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 18:28:06 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 18:28:09 INFO - Downloading blessings-1.6.tar.gz 18:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:28:09 INFO - Installing collected packages: blessings 18:28:09 INFO - Running setup.py install for blessings 18:28:09 INFO - Successfully installed blessings 18:28:09 INFO - Cleaning up... 18:28:09 INFO - Return code: 0 18:28:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:28:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:28:09 INFO - Reading from file tmpfile_stdout 18:28:09 INFO - Current package versions: 18:28:09 INFO - argparse == 1.2.1 18:28:09 INFO - blessings == 1.6 18:28:09 INFO - blobuploader == 1.2.4 18:28:09 INFO - docopt == 0.6.1 18:28:09 INFO - functools32 == 3.2.3-2 18:28:09 INFO - jsonschema == 2.5.1 18:28:09 INFO - manifestparser == 1.1 18:28:09 INFO - mozInstall == 1.12 18:28:09 INFO - mozcrash == 0.17 18:28:09 INFO - mozdebug == 0.1 18:28:09 INFO - mozdevice == 0.48 18:28:09 INFO - mozfile == 1.2 18:28:09 INFO - mozhttpd == 0.7 18:28:09 INFO - mozinfo == 0.9 18:28:09 INFO - mozleak == 0.1 18:28:09 INFO - mozlog == 3.3 18:28:09 INFO - moznetwork == 0.27 18:28:09 INFO - mozprocess == 0.23 18:28:09 INFO - mozprofile == 0.28 18:28:09 INFO - mozrunner == 6.12 18:28:09 INFO - mozscreenshot == 0.1 18:28:09 INFO - mozsystemmonitor == 0.3 18:28:09 INFO - moztest == 0.7 18:28:09 INFO - mozversion == 1.4 18:28:09 INFO - psutil == 3.1.1 18:28:09 INFO - requests == 1.2.3 18:28:09 INFO - wsgiref == 0.1.2 18:28:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:09 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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:28:09 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 18:28:09 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 18:28:09 INFO - Using env: {'DISPLAY': ':0', 18:28:09 INFO - 'HOME': '/home/cltbld', 18:28:09 INFO - 'LANG': 'en_US.UTF-8', 18:28:09 INFO - 'LANGUAGE': 'en_US:en', 18:28:09 INFO - 'LOGNAME': 'cltbld', 18:28:09 INFO - 'MAIL': '/var/mail/cltbld', 18:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:09 INFO - 'MOZ_NO_REMOTE': '1', 18:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:09 INFO - 'NO_EM_RESTART': '1', 18:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:09 INFO - 'PWD': '/builds/slave/test', 18:28:09 INFO - 'SHELL': '/bin/bash', 18:28:09 INFO - 'SHLVL': '1', 18:28:09 INFO - 'TERM': 'linux', 18:28:09 INFO - 'TMOUT': '86400', 18:28:09 INFO - 'USER': 'cltbld', 18:28:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:09 INFO - '_': '/tools/buildbot/bin/python'} 18:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:10 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)) 18:28:10 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)) 18:28:10 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)) 18:28:10 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)) 18:28:10 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)) 18:28:10 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)) 18:28:10 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)) 18:28:10 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)) 18:28:10 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)) 18:28:10 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)) 18:28:10 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)) 18:28:10 INFO - Cleaning up... 18:28:10 INFO - Return code: 0 18:28:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:28:10 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 0x2715030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', '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 18:28:10 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 18:28:10 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 18:28:10 INFO - Using env: {'DISPLAY': ':0', 18:28:10 INFO - 'HOME': '/home/cltbld', 18:28:10 INFO - 'LANG': 'en_US.UTF-8', 18:28:10 INFO - 'LANGUAGE': 'en_US:en', 18:28:10 INFO - 'LOGNAME': 'cltbld', 18:28:10 INFO - 'MAIL': '/var/mail/cltbld', 18:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:10 INFO - 'MOZ_NO_REMOTE': '1', 18:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:10 INFO - 'NO_EM_RESTART': '1', 18:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:10 INFO - 'PWD': '/builds/slave/test', 18:28:10 INFO - 'SHELL': '/bin/bash', 18:28:10 INFO - 'SHLVL': '1', 18:28:10 INFO - 'TERM': 'linux', 18:28:10 INFO - 'TMOUT': '86400', 18:28:10 INFO - 'USER': 'cltbld', 18:28:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:10 INFO - '_': '/tools/buildbot/bin/python'} 18:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:28:10 INFO - Cleaning up... 18:28:10 INFO - Return code: 0 18:28:10 INFO - Running post-action listener: _resource_record_post_action 18:28:10 INFO - Running post-action listener: _start_resource_monitoring 18:28:10 INFO - Starting resource monitoring. 18:28:10 INFO - [mozharness: 2016-08-02 01:28:10.351786Z] Finished create-virtualenv step (success) 18:28:10 INFO - [mozharness: 2016-08-02 01:28:10.352222Z] Running install step. 18:28:10 INFO - Running pre-action listener: _resource_record_pre_action 18:28:10 INFO - Running main action method: install 18:28:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:28:10 INFO - Reading from file tmpfile_stdout 18:28:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:28:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:28:10 INFO - Reading from file tmpfile_stdout 18:28:10 INFO - Output received: 18:28:10 INFO - Usage: mozinstall [options] installer 18:28:10 INFO - Options: 18:28:10 INFO - -h, --help show this help message and exit 18:28:10 INFO - -d DEST, --destination=DEST 18:28:10 INFO - Directory to install application into. [default: 18:28:10 INFO - "/builds/slave/test"] 18:28:10 INFO - --app=APP Application being installed. [default: firefox] 18:28:10 INFO - mkdir: /builds/slave/test/build/application 18:28:10 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'] 18:28:10 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 18:28:26 INFO - Reading from file tmpfile_stdout 18:28:26 INFO - Output received: 18:28:26 INFO - /builds/slave/test/build/application/firefox/firefox 18:28:26 INFO - Running post-action listener: _resource_record_post_action 18:28:26 INFO - [mozharness: 2016-08-02 01:28:26.706880Z] Finished install step (success) 18:28:26 INFO - [mozharness: 2016-08-02 01:28:26.707156Z] Running run-tests step. 18:28:26 INFO - Running pre-action listener: _resource_record_pre_action 18:28:26 INFO - Running main action method: run_tests 18:28:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:28:26 INFO - Python 2.7.3 18:28:26 INFO - Return code: 0 18:28:26 INFO - grabbing minidump binary from tooltool 18:28:26 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')]} 18:28:26 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 0x29d43b0>, '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 0x29d52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:28:26 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 18:28:26 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 18:28:26 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 18:28:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:28:26 INFO - Return code: 0 18:28:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:28:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:28:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:28:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:28:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:28:26 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/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 18:28:26 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/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 18:28:26 INFO - Using env: {'DISPLAY': ':0', 18:28:26 INFO - 'HOME': '/home/cltbld', 18:28:26 INFO - 'LANG': 'en_US.UTF-8', 18:28:26 INFO - 'LANGUAGE': 'en_US:en', 18:28:26 INFO - 'LOGNAME': 'cltbld', 18:28:26 INFO - 'MAIL': '/var/mail/cltbld', 18:28:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:28:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:26 INFO - 'MOZ_NO_REMOTE': '1', 18:28:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:28:26 INFO - 'NO_EM_RESTART': '1', 18:28:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:26 INFO - 'PWD': '/builds/slave/test', 18:28:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:28:26 INFO - 'SHELL': '/bin/bash', 18:28:26 INFO - 'SHLVL': '1', 18:28:26 INFO - 'TERM': 'linux', 18:28:26 INFO - 'TMOUT': '86400', 18:28:26 INFO - 'USER': 'cltbld', 18:28:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136', 18:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:26 INFO - '_': '/tools/buildbot/bin/python'} 18:28:26 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/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 18:28:26 INFO - mozversion application_buildid: 20160801154050 18:28:26 INFO - mozversion application_changeset: 53406372ffafd9cafd7ea4b8802a5fa7876bcfe5 18:28:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:28:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:28:26 INFO - mozversion application_name: Firefox 18:28:26 INFO - mozversion application_remotingname: firefox-dev 18:28:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:28:26 INFO - mozversion application_vendor: Mozilla 18:28:26 INFO - mozversion application_version: 50.0a2 18:28:26 INFO - mozversion platform_buildid: 20160801154050 18:28:26 INFO - mozversion platform_changeset: 53406372ffafd9cafd7ea4b8802a5fa7876bcfe5 18:28:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:28:26 INFO - mozversion platform_version: 50.0a2 18:28:26 INFO - using testdate: 1470101306 18:28:26 INFO - actual date: 1470101306 18:28:26 INFO - starting webserver on 'localhost:48295' 18:28:26 INFO - SUITE-START | Running 2 tests 18:28:26 INFO - TEST-START | dromaeo_css 18:28:26 INFO - operating with platform_type : linux_ 18:28:26 INFO - Initialising browser for dromaeo_css test... 18:28:26 INFO - TEST-INFO | started process 8364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7lo9M7/profile http://localhost:48295/getInfo.html) 18:28:31 INFO - PROCESS | 8364 | __metrics Screen width/height:1600/1200 18:28:31 INFO - PROCESS | 8364 | colorDepth:24 18:28:31 INFO - PROCESS | 8364 | Browser inner width/height: 1024/697 18:28:31 INFO - PROCESS | 8364 | __metrics 18:28:32 INFO - PROCESS | 8364 | 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" 18:28:32 INFO - PROCESS | 8364 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:28:32 INFO - TEST-INFO | 8364: exit 0 18:28:32 INFO - Browser initialized. 18:28:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:28:32 INFO - TEST-INFO | started process 8453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7lo9M7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:28:44 INFO - PROCESS | 8453 | RSS: Main: 145387520 18:28:44 INFO - PROCESS | 8453 | 18:29:35 INFO - PROCESS | 8453 | 1470101375473 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] 18:31:44 INFO - PROCESS | 8453 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48295/tests/dromaeo/cssquery-ext.html) 18:31:45 INFO - PROCESS | 8453 | RSS: Main: 221491200 18:31:45 INFO - PROCESS | 8453 | 18:34:48 INFO - PROCESS | 8453 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-ext.html (next: http://localhost:48295/tests/dromaeo/cssquery-jquery.html) 18:34:48 INFO - PROCESS | 8453 | RSS: Main: 234192896 18:34:48 INFO - PROCESS | 8453 | 18:37:50 INFO - PROCESS | 8453 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48295/tests/dromaeo/cssquery-mootools.html) 18:37:51 INFO - PROCESS | 8453 | RSS: Main: 203567104 18:37:51 INFO - PROCESS | 8453 | 18:40:53 INFO - PROCESS | 8453 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48295/tests/dromaeo/cssquery-prototype.html) 18:40:53 INFO - PROCESS | 8453 | RSS: Main: 173830144 18:40:53 INFO - PROCESS | 8453 | 18:43:56 INFO - PROCESS | 8453 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48295/tests/dromaeo/cssquery-yui.html) 18:43:57 INFO - PROCESS | 8453 | RSS: Main: 175136768 18:43:57 INFO - PROCESS | 8453 | 18:46:59 INFO - PROCESS | 8453 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-yui.html (next: http://localhost:48295/tests/dromaeo/cssquery-dojo.html) 18:46:59 INFO - PROCESS | 8453 | RSS: Main: 270020608 18:46:59 INFO - PROCESS | 8453 | 18:46:59 INFO - PROCESS | 8453 | __start_tp_report 18:46:59 INFO - PROCESS | 8453 | _x_x_mozilla_page_load 18:46:59 INFO - PROCESS | 8453 | _x_x_mozilla_page_load_details 18:46:59 INFO - PROCESS | 8453 | |i|pagename|runs| 18:46:59 INFO - PROCESS | 8453 | |0;dojo.html;3226.7257283130934;3254.397936381769;3265.7224135948445;3275.0993476793865;3314.651961544038;5641.717914104299;5727.942720572803;5736.741846616902;5757.596968212227;5785.508231800297;5692.544596432286;5772.855678608037;5773.884522309551;5788.334341550723;5816.621919575236;5044.545990860822;5156.458571849958;5236.057509648262;5237.162054071349;5255.316808814849;5218.869528261805;5271.973640131794;5273.472652734734;5274.762635681384;5286.180642000477;5156.046131465672;5196.766145523442;5197.792088316482;5214.791408343662;5256.369235691723;5300.575953923677;5316.255724198615;5326.227696983954;5327.7336133193185;5359.705216213107;4995.800167993276;5060.114479966028;5102.336696229503;5192.688438693691;5198.16829307309;5567.972160139214;5605.243292155547;5631.774729010835;5638.633488823213;5708.372079071299;6099.225764022442;6100.270069239556;6100.638635718798;6103.816885493442;6105.847353816146;5948.762049518057;5981.9401805981815;6054.576179667425;6059.939400606026;6114.501947023008;5700.7719691212305;5703.800366987136;5711.885762284773;5721.170430287627;5726.2555867737765;6207.720652570645;6212.192414986023;6223.066540019034;6226.034964580497;6226.719797609118;5821.650700957872;5992.850178745566;6050.820090082391;6062.848428789315;6120.14317995481;6204.410580994799;6210;6212.161358216583;6212.192414986023;6212.844678883064;6114.847128821815;6159.3224745277985;6161.075838624242;6169.81490555284;6171.814845554641;5908;6001.489873360813;6038.788642397583;6052.939470605325;6090.908636370458;4661.603763680057;4695.647826413033;4695.835645752382;4698.3187437821325;4728.645351598644;4176.791160441966;4181.560936101666;4190.8533201337805;4193.266178418765;4222.282212023963;5667.971660141673;5758.424157584208;5810.331811841608;5822.184894114827;5895.793647222413;6124.846878828065;6131.437835141539;6132.63204207749;6138.235132557318;6139.035508637193;5834.562407819346;5838.591298609056;5840.445157710095;5841.065429531254;5861.150133230658;5177.870553236199;5257.132573125392;5294.232336311214;5310.522053015247;5369.3556773187465;6394.552381333355;6417.647029413427;6438.291787903327;6454.9677251614385;6459.870802583922;6171.660558669137;6212.06818977157;6229.657368844576;6233.688315584293;6244.0321750128805;6180.81457556274;6343.90484142729;6390.520710946605;6390.584612000205;6468.482521398183;6110.908336374869;6117.724702388492;6118.755249789959;6121.32665406796;6123.601965872204;6225.470834979077;6228.159198508143;6232.937670623417;6234.875302494015;6235.189425374853;5832.94167058324;5874.324452687995;5893.764249429974;5896.852578685395;5981.850453738692;5907.940920590739;5946.732397042057;5948.910766338595;5958.314793798769;5965.045592705146;5862.443067908542;5874.618149820248;5875.236219291465;5915;5937;5834.82495525118;6014.609050411709;6092.888142585961;6117.082437634391;6118.235220597426;5924.289085309791;5947.732352044255;5951.494122999594;5954.672493012926;5956.285245770535 18:46:59 INFO - PROCESS | 8453 | |1;ext.html;605.9606125601836;616.5776443136451;638.4509321983095;643.8519140597663;660.791850567071;35302.99999999997;47358;48517.331546764915;48600.75699621497;48674.51325486744;49506.25740613894;49934.750326248315;49936.75031624846;50046.74976625121;50109.749451252785;8382.87425688615;9282;9422.481763503005;9476.336656434052;11088.002079812815;10954.507047182857;11436.656900292963;11441.713957151054;11444.599439019636;11454.312741235553;11467.483963221675;11536;11537.884621153808;11539.884601153964;11542.596009139681;11455.885441145607;11481.598144064918;11504;11504.884951150465;11513.481893314822;11308.604198853083;11330.71673208168;11355.261907975955;11395.829062564067;11403;46668.53331466676;47061.52938470606;47182.05635887297;47252;47260.527394725956;3929.0373858404587;4124.752514849089;4242.045539753562;4304.332828411601;4627.676062675614;35269.82365088184;35472.29055418903;35510.28979420423;35882.10294742626;37480.437793432844;3778.886633401002;3874.6900247980375;3898.2203559288255;3911.5892831252595;3982.163745613396;384240;385199;387165;388885;390623;35844;36905.63094369022;36906.63093369032;39017;65781.6710916452;39840.203195935916;39926;39944.60055399467;39951.40072898909;39956.80021599874;17038.914805425895;17392.47822565325;17436.215370308368;17461.126943652765;17465.7380139298;12478.563250286197;12530.185537940004;13008;13169.934150329187;14143.222122783345;9214.815703686023;9317.347785655074;9342;9386.671466498776;9402.764930876647;3518.648135186461;3518.964810351864;3539.752217344813;3551.2542366103407;3628.963710362915;1086.6631344283298;1114.9944250278697;1147.4205526209378;1234.9876501235053;1237.826704261404;35926.281474370364;36562.451563226576;36854.81572592173;36900.815495922885;36975.63024369776;1123.662901129658;1175.6884425627215;1235.7827539873217;1247.1581682364367;1254.404158024949;18894.426144287194;18908.43274701761;19145.904270478557;19239.90380048119;19243;599091;600500;603558;604620.8382706584;604622;66083;66521;66635;66725;66826.66586667036;1343.737971095627;1441.2001339256603;1484.829244636859;1500.8349081601016;1502.1662977047843;35295.647043529236;37150.44274335941;37448.2510349786;37554.62445375621;37671.623283766814;53957.190642141184;54063.18905216346;55615;55662.72168639293;61499.6925015372;556655;560712;561507;561882;563490;31185.8440707795;31546.36907261796;31553.842230788698;33303.50044749282;49379.753101234266;52934.73532632312;53570.73214633902;53651.46348536465;53663.463365365846;53974.73012634912;44867.55132448634;45668.314975274734;46032;46324.7683761579;47333.29000064933;44414;45848.312275316566;46338;46769;46894.29658555193;45642.31536527021;46385;46910.765446173915;49007.50992490172;49628.25557616566;39332.80333598314;40715.38926916039;40736;40898;40987.59012409957;30976.380472390876;31127.37745245037;31175.84412077925;31402;31560.36879262448 18:46:59 INFO - PROCESS | 8453 | |2;jquery.html;394.26666400495094;419.91312806387305;434.91301739652073;439.7823077576599;442.307788311293;16079.919600401996;20538.383848484533;20549.280775172854;20590.897045514772;21446.463838404008;20139.395818125442;20285;20359.796402035976;20432.795672043314;20592.691109633368;4122.0931395093185;5747.080467125261;5779.595428320019;5861.150133230679;6028.21633187685;5972.492338151263;6013.759449622032;6083;6083.908741368883;6097.146399504073;5718.08510638298;5954.2259506264345;5984.162217289583;6076.301225359074;6084.96957515214;6025.969870150621;6035.094735789623;6055.000924847395;6065.605735627192;6071.787487437962;5768.509676677488;5907.202527658754;5994.460498555151;5997.910031349533;6000.159977603139;14610.488632897905;14647.70704585913;14713.264336783224;14780.408783648749;14893.255337233095;2390.3546042568582;2558.60341647045;2716.0358072884237;2767.9446411071867;2960.008397186945;10672.733181670443;11336.263142895685;13238.007149463732;15063.623409414853;15418.074915504993;2015.304719871642;2023.5447024419534;2039.7450318710162;2088.644930361827;2098.821600163988;84281.57859210727;85257.57371213104;86459;87924;88714.55642721745;11471.967522922978;11518.539258429737;11886.643400697993;11929.880701193051;11976.940115299367;16201.189940503164;16223.026618402697;16243.756343654855;16272.674546509004;16293.837061629232;8486.405951583454;8742.269677297756;8802.33982451306;8959.059298773665;9056.04911484298;8701.651933922698;8851.734447966572;8894.688685896092;9088.272938165062;9110.772230694152;4564.2240819060835;4900.705957642553;5060.544550990428;5068.9375506893875;5195.688258704414;1935.332310352926;2059.567490826913;2069.751629804403;2133.871967681944;2137.3053757528555;971.3977334052933;1063.7925604507202;1087.1628845788857;1115.11905594581;1171.543098191706;20535.691964620542;20610.896945515477;20702.171913123308;20940.685889711665;21007.579848403253;1027.6043723166636;1033.2715435617872;1033.8914413986574;1046.8063408269495;1056.9735756606146;10829.776674937966;11649.650510484698;11678.824817627743;11706.765864682659;11717.414129293502;512282;523702;525418;530936;538028;93397;95150.52424737831;95302;97678;99670;980.1472718734603;1022.1618273016204;1030.8247597908373;1056.028453822485;1057.080340104099;17936.820631793515;18160;18508.9820059898;18680;18717.906410467862;45751.77124114358;46119.538804612865;46330.07339853117;46834.53165468438;47787.522124778305;61401;63145.36854631395;63627.6818615904;64013;64271.35728642654;5359.035373632783;6769.8491256487505;8163.428560000743;8578.78553036179;8882.822343552964;11770.646880593597;13534.86465135336;13577.32113394346;13778.793318100035;14111.717765644835;11690.415479226174;11864;11936.641900742645;12125.514979400725;12369.814452783396;11777.352245626573;11938.64184074479;12006.519739210335;12066.457009434422;12201.145919785884;12054.638360849189;12085.577004804789;12134.514619415124;12193.69515762113;12533.74932501363;8717.476951382938;8801.427907186013;8897.510636915033;8950.910490895008;9004.59479323419;10782.784344312913;11052.557897684002;11905.761884762083;11956.76086478283;12183.573574924834 18:46:59 INFO - PROCESS | 8453 | |3;mootools.html;1465.5676575410266;1517.051842598376;1607.1321486397346;1769.7079981803004;1913.512054426121;9359.81280374393;9655.758606034853;9773.755656108591;10105.545250463729;10159.796804063913;9909.355891867024;10029.498525073754;10064.949675251632;10068.395896246231;10071.244656650744;2396.928092157238;2423.4789520253144;2425.733169351379;2429.392651837041;2429.6112621980396;2408.494216214597;2412.4089598048504;2442.426029882976;2446.8898899549563;2448.179859746987;2421.1889017179265;2441.1944058460754;2446.290575733044;2450.13020377766;2451;2387.3196139100446;2388.9641655375185;2398.0767404549288;2398.412388964706;2422.8667423291713;2362.2204672458047;2364.9763502364926;2365.7161140663056;2366.8934897929635;2369.845960012594;9685.6610018649;10006.09945104944;10058.295919285652;10064.194864410829;10073.395596264247;5900.852478688067;5989.730462129171;5991;6046.09308603713;6063.878722425571;3640.5449318835144;3696.537932758405;3770.6794922431627;3772.6981841452894;3781.3382658035007;1133.4955944604653;1141.2809929744208;1144.096164030415;1163.9301641901513;1171.1567671276753;14379.209143497104;14485.42058317666;14522.128672279803;14522.636934076627;14558.199299038548;4956.355673762388;5010.498950105033;5049.2426136079885;5088.185890257541;5193.169092945186;11115.777684446428;11152.996230339308;11154.330740155616;11157.38634375101;11160.386178760245;5832.24180856486;5835.328937172279;5840.561957853093;5852.736626851802;5857;4866.148424025781;4872.561469467765;5368.624196306299;5423.701696406735;5450.400455949843;4178.644815190682;4194.42708984131;4224.091820258659;4287.442632457761;4290.849820256276;1235.199713807304;1271.7456508698297;1284.3321472834075;1290.587012156101;1297.1179597873536;1060.984085238722;1082.767205050918;1098.1763677242068;1104.2877344113;1118.2340097033557;6775.254721980578;6908.620025898524;6959.582425054412;7021.859562808715;7115.146182458035;466.8856130248111;489.43714728062304;501.45341577680506;501.92471129330164;503.02915373329097;4804.73573953429;4810.927836082462;4837.346958160603;4884.780184891689;4885.340479035356;12568.560100396626;12964.157329773534;13025.674358141123;13072.673183170307;13074.346282685829;12451.315177665134;12647.114701970773;12910.096293259381;12913.741725165444;12919.031072669588;9347.672831450867;9411.20004799586;9448.48033358172;9469.289803264921;9543.379680320757;6626.867462650816;6887.552309099892;6889.586624802528;6913.10129683138;6954.443644508326;11759.941200293944;11798.528058877891;11819.11356648272;11872.406379680808;11930.761384772082;11735.23720958135;11878;11983.940080299542;12055.276683399024;12132.636020919386;8452.704155354533;8575.056743758307;8632.91367086321;8648.04871464151;8660.220580147818;9655.565499552396;9712;9780.315377923476;9780.755481113029;9800.460974646463;8328.708495202882;8521.147885211429;8553.44402613828;8624.223819856243;8790.648374064966;8575.31397488187;8686.261667758312;8718.782030449036;8866.60100295501;8926.86609700842;8082.87875681877;8193.057798353027;8194.83610327802;8198.918010819816;8199.467034642728;5787.276590426197;5800.970995145166;5867.354590995073;5869.06095024794;6030.065339872327;5643.689597072201;5777.7977770777825;5784.768609255582;6069.726862291119;6069.757209711562 18:46:59 INFO - PROCESS | 8453 | |4;prototype.html;353.6269235956066;353.6799196726963;361.28645924299514;361.7124386113041;364.61350967973965;5487.231787549741;5492.945070549294;5543.946650136481;5548.334199896008;5577.972110139453;5387.515123638872;5451.700156491392;5486.177073438987;5491.780328786854;5495.807646732365;4190.7066505344565;4317.935230971538;4340.631046361063;4349.913001739963;4369.213541562517;4289.678274129437;4290.42079319291;4335.111302183045;4335.653147748172;4336.21948049351;4042.0501182222156;4283.121959998193;4305.698601097924;4324.502682191541;4343.4363629093505;4096.938545921814;4216.156768646252;4255.127698821734;4267.8079486423185;4298.226319262531;3821.14024344523;3824.4454554089502;3827.827747751358;3833.8274777634792;3835.7314987950854;5059.723124593911;5297.337832770903;5306.52241298285;5312.601554883399;5357.1696387060065;4539.114872599845;4832.9459979508565;4853.635977301717;4879.951200487985;4883.12103821312;5636.520895723868;5650.604457687963;5659.349174844863;5664.178694089334;5696.629719068247;4053.067794407273;4174.895627609304;4185.22573323936;4188.099558594886;4193.071187253867;5843.240378750777;5859.29688437386;5862.768818548067;5872.677002764846;5906.527477801808;4264.360345948133;4274.482558691682;4302.827886884552;4314.546972567898;4315.09383029561;4270.551592082787;4363.083752411965;4365.454318210223;4370.191514569815;4376.3654270130655;4865.610751139971;4868.123737727243;4872.78072486739;4911.45973942866;4962.354893863775;5679.807240479463;5683.687397193194;5720.913026524947;5762.1068734346245;5789.507891829242;1450.6228380621114;1481.4296495849176;1492.6492274315526;1501.81978162619;1507.8718308943644;941.2093841173447;964.864918911353;976.9951150244345;982.0523195116747;983.6704703924122;4865.270209468537;4894.1679914414635;4919.458859525449;4926.482719314492;4955.925661115014;5093.617978651542;5101.744912754348;5106.234064890222;5144.71704056273;5159.277701121846;4936.802527898915;4949.515145456421;5065.965125035478;5338.3060202173465;5481.643693159932;2998.3553535989868;3025.878964841426;3026.3947210557976;3083.7070478304527;3084.0901933929545;6070.848228794227;6074.20362273579;6081.148639190517;6091.964366057781;6092.786752463731;5718.428157184331;5978.192943952511;5983.128098512739;6022.307434644984;6034.758609655652;6110.816675499742;6111.258291386934;6131.662758548234;6146.170267013986;6150.661713605705;5646.689432081275;5884.852878678067;5904.498117660047;5907.940920590911;5909.349971503045;5837.5329973601165;5840.474357307863;5851.941480585139;5860.208871802422;5861.35525092248;6098.359672234352;6104.298005729398;6112.113743507255;6123.326434092157;6127.3259941407305;4021.798910054427;4174.20690068886;4207.4109624651965;4224.486430573804;4236.851710190129;5872.941270587239;5913.793017244548;5916.994111001054;5927;5959.22530071088;5695.724958149163;5793.333766616893;5806.854828629318;5818.33089194748;5860.8571328592225;5742.626729262584;5746.655200687972;5752.252207213203;5755.769769209185;5763.308402991668;5481.917771233514;5604.271444712162;5708.343540492897;5726.770929162787;5751.396103409082;5654.943450565606;5784;5807.361190269152;5813.302403711582;5824.126381042877;5652.378238393691;5653.745581448927;5662.320521537277;5674.893395787947;5683.8863222736145 18:46:59 INFO - PROCESS | 8453 | |5;yui.html;784.6812668564392;792.413613925695;797.2585495489196;806.2501873257871;880.9471431714094;17088.145592720375;18290.451286461393;18315.633687326244;18317.908410457945;18346.449606511793;16153.273102710376;16493.34026638933;16526.25631846567;16578.253978570963;16611.41860034899;710.2897102897103;819.1644522586957;843.5908584336592;845.9788505287355;860.9225169734739;845.9323254139654;851.199872120205;857.3269983063296;858.4505916213628;859.325429537813;908.7319240823973;910.1581037540282;910.3763921713614;911.9740292171307;919.4896832258094;754.7396148328872;913.7852604637905;916.083916083916;918.9310801689867;920.2913756407562;658.3383699382139;679.7281087564965;684.5208354152113;684.9828754281133;685.6811582614108;16635.750463743054;16638.0849053302;16668;16695.74956375655;16721.080340581262;15287.541373758804;15399.384024639001;15650.608734781608;15825.28786204612;15992.36030558788;14454.205018723966;14526.636834079232;14543.200123993176;14575.19836408997;14708.33812478441;4672.0889426561835;4749.810007599692;4750.12122757291;4785.138675038526;4835.758212089417;84271;87048.5647571758;87779;88946.55526722454;90261.09738902592;12624.17942833713;12658.367081645882;12771.744565108645;12787;12851.742965140646;24349.756502435102;24576.754232457446;24628.876855615606;25274.747252527606;25330.493390132462;9437.480938548446;9457.24342052648;9526.428414295164;9748;9811.509424528887;5035.84892453227;5086.237064440364;5138.845834624967;5181.171012637959;5395.3525576931015;3865.0530619997717;3966.4446977423186;3973.7814420206587;3974.066094467798;3976.363781794899;657.9407853293227;674.1707699529607;676.35746041261;684.288340126273;693.6219760230687;667;735.6873328835223;748.1657951384168;762.5158024654385;770.3336613828998;9787.608495660093;10206.746680489765;10347.4308913009;10916.890831091747;11016.889831101747;610.7866101343152;637.3276193615687;745.4446437404168;755.3126654744157;756.5574139128562;5127.2857655073085;5161.716105614228;5185.533302002837;5264.842054738364;5447.782088716407;75025.62487187529;82045.58977205076;128411;133671;139094;75184.24815751881;78805.60597196977;116552.41723791327;116929;118648;98343.50828245813;99462.50268748609;100401.49799251102;100538;102309.48845255875;9242.907570924204;9317.813643727222;9334.813303733752;9457.131082013806;9517.588691381472;48812.2678159835;57394.7130264346;57600.135997960904;57687.423125768204;57729.13406298825;47081.52918470772;65844.67077664581;69209.65395172992;70719.64640176766;78803.21196787959;14838.258087095817;14872.107673539622;14999;15291.61770955735;15690;16220.27008784584;17031.23359448803;17327.2202750874;17769.555761106076;18620.255189792257;15939.282732276843;16710.66578668444;16769.413070542472;16864.83135168682;17190.828091718922;15894.364225430852;15902.125383104041;16269.75595366094;16795.32818687239;16802.831971680127;15354.539363819104;15582.766258506359;16240.18799060066;16729.91635041817;16740.24668889927;11930.522779088738;11956.06273629199;12482.812757808459;12539.93730031344;12866.163699359511;12089.879101208875;12299.262044277371;13253.867461325262;13461.394237259543;13701.45194192221 18:46:59 INFO - PROCESS | 8453 | __end_tp_report 18:46:59 INFO - PROCESS | 8453 | __start_cc_report 18:46:59 INFO - PROCESS | 8453 | _x_x_mozilla_cycle_collect,1041 18:46:59 INFO - PROCESS | 8453 | __end_cc_report 18:46:59 INFO - PROCESS | 8453 | __startTimestamp1470102419906__endTimestamp 18:46:59 INFO - PROCESS | 8453 | 18:46:59 INFO - PROCESS | 8453 | ------- Summary: start ------- 18:46:59 INFO - PROCESS | 8453 | Number of tests: 6 18:46:59 INFO - PROCESS | 8453 | 18:46:59 INFO - PROCESS | 8453 | [#0] dojo.html Cycles:165 Average:5695.70 Median:5895.79 stddev:654.94 (11.1%) stddev-sans-first:627.66 18:46:59 INFO - PROCESS | 8453 | Values: 3226.7 3254.4 3265.7 3275.1 3314.7 5641.7 5727.9 5736.7 5757.6 5785.5 5692.5 5772.9 5773.9 5788.3 5816.6 5044.5 5156.5 5236.1 5237.2 5255.3 5218.9 5272.0 5273.5 5274.8 5286.2 5156.0 5196.8 5197.8 5214.8 5256.4 5300.6 5316.3 5326.2 5327.7 5359.7 4995.8 5060.1 5102.3 5192.7 5198.2 5568.0 5605.2 5631.8 5638.6 5708.4 6099.2 6100.3 6100.6 6103.8 6105.8 5948.8 5981.9 6054.6 6059.9 6114.5 5700.8 5703.8 5711.9 5721.2 5726.3 6207.7 6212.2 6223.1 6226.0 6226.7 5821.7 5992.9 6050.8 6062.8 6120.1 6204.4 6210.0 6212.2 6212.2 6212.8 6114.8 6159.3 6161.1 6169.8 6171.8 5908.0 6001.5 6038.8 6052.9 6090.9 4661.6 4695.6 4695.8 4698.3 4728.6 4176.8 4181.6 4190.9 4193.3 4222.3 5668.0 5758.4 5810.3 5822.2 5895.8 6124.8 6131.4 6132.6 6138.2 6139.0 5834.6 5838.6 5840.4 5841.1 5861.2 5177.9 5257.1 5294.2 5310.5 5369.4 6394.6 6417.6 6438.3 6455.0 6459.9 6171.7 6212.1 6229.7 6233.7 6244.0 6180.8 6343.9 6390.5 6390.6 6468.5 6110.9 6117.7 6118.8 6121.3 6123.6 6225.5 6228.2 6232.9 6234.9 6235.2 5832.9 5874.3 5893.8 5896.9 5981.9 5907.9 5946.7 5948.9 5958.3 5965.0 5862.4 5874.6 5875.2 5915.0 5937.0 5834.8 6014.6 6092.9 6117.1 6118.2 5924.3 5947.7 5951.5 5954.7 5956.3 18:46:59 INFO - PROCESS | 8453 | 18:46:59 INFO - PROCESS | 8453 | [#1] ext.html Cycles:180 Average:67748.49 Median:21457.61 stddev:139744.59 (651.3%) stddev-sans-first:140045.68 18:46:59 INFO - PROCESS | 8453 | Values: 606.0 616.6 638.5 643.9 660.8 35303.0 47358.0 48517.3 48600.8 48674.5 49506.3 49934.8 49936.8 50046.7 50109.7 8382.9 9282.0 9422.5 9476.3 11088.0 10954.5 11436.7 11441.7 11444.6 11454.3 11467.5 11536.0 11537.9 11539.9 11542.6 11455.9 11481.6 11504.0 11504.9 11513.5 11308.6 11330.7 11355.3 11395.8 11403.0 46668.5 47061.5 47182.1 47252.0 47260.5 3929.0 4124.8 4242.0 4304.3 4627.7 35269.8 35472.3 35510.3 35882.1 37480.4 3778.9 3874.7 3898.2 3911.6 3982.2 384240.0 385199.0 387165.0 388885.0 390623.0 35844.0 36905.6 36906.6 39017.0 65781.7 39840.2 39926.0 39944.6 39951.4 39956.8 17038.9 17392.5 17436.2 17461.1 17465.7 12478.6 12530.2 13008.0 13169.9 14143.2 9214.8 9317.3 9342.0 9386.7 9402.8 3518.6 3519.0 3539.8 3551.3 3629.0 1086.7 1115.0 1147.4 1235.0 1237.8 35926.3 36562.5 36854.8 36900.8 36975.6 1123.7 1175.7 1235.8 1247.2 1254.4 18894.4 18908.4 19145.9 19239.9 19243.0 599091.0 600500.0 603558.0 604620.8 604622.0 66083.0 66521.0 66635.0 66725.0 66826.7 1343.7 1441.2 1484.8 1500.8 1502.2 35295.6 37150.4 37448.3 37554.6 37671.6 53957.2 54063.2 55615.0 55662.7 61499.7 556655.0 560712.0 561507.0 561882.0 563490.0 31185.8 31546.4 31553.8 33303.5 49379.8 52934.7 53570.7 53651.5 53663.5 53974.7 44867.6 45668.3 46032.0 46324.8 47333.3 44414.0 45848.3 46338.0 46769.0 46894.3 45642.3 46385.0 46910.8 49007.5 49628.3 39332.8 40715.4 40736.0 40898.0 40987.6 30976.4 31127.4 31175.8 31402.0 31560.4 18:46:59 INFO - PROCESS | 8453 | 18:46:59 INFO - PROCESS | 8453 | [#2] jquery.html Cycles:180 Average:30710.68 Median:2135.59 stddev:86776.25 (4063.3%) stddev-sans-first:86989.83 18:46:59 INFO - PROCESS | 8453 | Values: 394.3 419.9 434.9 439.8 442.3 16079.9 20538.4 20549.3 20590.9 21446.5 20139.4 20285.0 20359.8 20432.8 20592.7 4122.1 5747.1 5779.6 5861.2 6028.2 5972.5 6013.8 6083.0 6083.9 6097.1 5718.1 5954.2 5984.2 6076.3 6085.0 6026.0 6035.1 6055.0 6065.6 6071.8 5768.5 5907.2 5994.5 5997.9 6000.2 14610.5 14647.7 14713.3 14780.4 14893.3 2390.4 2558.6 2716.0 2767.9 2960.0 10672.7 11336.3 13238.0 15063.6 15418.1 2015.3 2023.5 2039.7 2088.6 2098.8 84281.6 85257.6 86459.0 87924.0 88714.6 11472.0 11518.5 11886.6 11929.9 11976.9 16201.2 16223.0 16243.8 16272.7 16293.8 8486.4 8742.3 8802.3 8959.1 9056.0 8701.7 8851.7 8894.7 9088.3 9110.8 4564.2 4900.7 5060.5 5068.9 5195.7 1935.3 2059.6 2069.8 2133.9 2137.3 971.4 1063.8 1087.2 1115.1 1171.5 20535.7 20610.9 20702.2 20940.7 21007.6 1027.6 1033.3 1033.9 1046.8 1057.0 10829.8 11649.7 11678.8 11706.8 11717.4 512282.0 523702.0 525418.0 530936.0 538028.0 93397.0 95150.5 95302.0 97678.0 99670.0 980.1 1022.2 1030.8 1056.0 1057.1 17936.8 18160.0 18509.0 18680.0 18717.9 45751.8 46119.5 46330.1 46834.5 47787.5 61401.0 63145.4 63627.7 64013.0 64271.4 5359.0 6769.8 8163.4 8578.8 8882.8 11770.6 13534.9 13577.3 13778.8 14111.7 11690.4 11864.0 11936.6 12125.5 12369.8 11777.4 11938.6 12006.5 12066.5 12201.1 12054.6 12085.6 12134.5 12193.7 12533.7 8717.5 8801.4 8897.5 8950.9 9004.6 10782.8 11052.6 11905.8 11956.8 12183.6 18:46:59 INFO - PROCESS | 8453 | 18:46:59 INFO - PROCESS | 8453 | [#3] mootools.html Cycles:180 Average:6567.33 Median:4186.54 stddev:3903.32 (93.2%) stddev-sans-first:3895.44 18:46:59 INFO - PROCESS | 8453 | Values: 1465.6 1517.1 1607.1 1769.7 1913.5 9359.8 9655.8 9773.8 10105.5 10159.8 9909.4 10029.5 10064.9 10068.4 10071.2 2396.9 2423.5 2425.7 2429.4 2429.6 2408.5 2412.4 2442.4 2446.9 2448.2 2421.2 2441.2 2446.3 2450.1 2451.0 2387.3 2389.0 2398.1 2398.4 2422.9 2362.2 2365.0 2365.7 2366.9 2369.8 9685.7 10006.1 10058.3 10064.2 10073.4 5900.9 5989.7 5991.0 6046.1 6063.9 3640.5 3696.5 3770.7 3772.7 3781.3 1133.5 1141.3 1144.1 1163.9 1171.2 14379.2 14485.4 14522.1 14522.6 14558.2 4956.4 5010.5 5049.2 5088.2 5193.2 11115.8 11153.0 11154.3 11157.4 11160.4 5832.2 5835.3 5840.6 5852.7 5857.0 4866.1 4872.6 5368.6 5423.7 5450.4 4178.6 4194.4 4224.1 4287.4 4290.8 1235.2 1271.7 1284.3 1290.6 1297.1 1061.0 1082.8 1098.2 1104.3 1118.2 6775.3 6908.6 6959.6 7021.9 7115.1 466.9 489.4 501.5 501.9 503.0 4804.7 4810.9 4837.3 4884.8 4885.3 12568.6 12964.2 13025.7 13072.7 13074.3 12451.3 12647.1 12910.1 12913.7 12919.0 9347.7 9411.2 9448.5 9469.3 9543.4 6626.9 6887.6 6889.6 6913.1 6954.4 11759.9 11798.5 11819.1 11872.4 11930.8 11735.2 11878.0 11983.9 12055.3 12132.6 8452.7 8575.1 8632.9 8648.0 8660.2 9655.6 9712.0 9780.3 9780.8 9800.5 8328.7 8521.1 8553.4 8624.2 8790.6 8575.3 8686.3 8718.8 8866.6 8926.9 8082.9 8193.1 8194.8 8198.9 8199.5 5787.3 5801.0 5867.4 5869.1 6030.1 5643.7 5777.8 5784.8 6069.7 6069.8 18:46:59 INFO - PROCESS | 8453 | 18:46:59 INFO - PROCESS | 8453 | [#4] prototype.html Cycles:180 Average:4797.64 Median:5466.67 stddev:1401.70 (25.6%) stddev-sans-first:1365.36 18:46:59 INFO - PROCESS | 8453 | Values: 353.6 353.7 361.3 361.7 364.6 5487.2 5492.9 5543.9 5548.3 5578.0 5387.5 5451.7 5486.2 5491.8 5495.8 4190.7 4317.9 4340.6 4349.9 4369.2 4289.7 4290.4 4335.1 4335.7 4336.2 4042.1 4283.1 4305.7 4324.5 4343.4 4096.9 4216.2 4255.1 4267.8 4298.2 3821.1 3824.4 3827.8 3833.8 3835.7 5059.7 5297.3 5306.5 5312.6 5357.2 4539.1 4832.9 4853.6 4880.0 4883.1 5636.5 5650.6 5659.3 5664.2 5696.6 4053.1 4174.9 4185.2 4188.1 4193.1 5843.2 5859.3 5862.8 5872.7 5906.5 4264.4 4274.5 4302.8 4314.5 4315.1 4270.6 4363.1 4365.5 4370.2 4376.4 4865.6 4868.1 4872.8 4911.5 4962.4 5679.8 5683.7 5720.9 5762.1 5789.5 1450.6 1481.4 1492.6 1501.8 1507.9 941.2 964.9 977.0 982.1 983.7 4865.3 4894.2 4919.5 4926.5 4955.9 5093.6 5101.7 5106.2 5144.7 5159.3 4936.8 4949.5 5066.0 5338.3 5481.6 2998.4 3025.9 3026.4 3083.7 3084.1 6070.8 6074.2 6081.1 6092.0 6092.8 5718.4 5978.2 5983.1 6022.3 6034.8 6110.8 6111.3 6131.7 6146.2 6150.7 5646.7 5884.9 5904.5 5907.9 5909.3 5837.5 5840.5 5851.9 5860.2 5861.4 6098.4 6104.3 6112.1 6123.3 6127.3 4021.8 4174.2 4207.4 4224.5 4236.9 5872.9 5913.8 5917.0 5927.0 5959.2 5695.7 5793.3 5806.9 5818.3 5860.9 5742.6 5746.7 5752.3 5755.8 5763.3 5481.9 5604.3 5708.3 5726.8 5751.4 5654.9 5784.0 5807.4 5813.3 5824.1 5652.4 5653.7 5662.3 5674.9 5683.9 18:46:59 INFO - PROCESS | 8453 | 18:46:59 INFO - PROCESS | 8453 | [#5] yui.html Cycles:180 Average:22347.78 Median:4749.97 stddev:31448.52 (662.1%) stddev-sans-first:31495.06 18:46:59 INFO - PROCESS | 8453 | Values: 784.7 792.4 797.3 806.3 880.9 17088.1 18290.5 18315.6 18317.9 18346.4 16153.3 16493.3 16526.3 16578.3 16611.4 710.3 819.2 843.6 846.0 860.9 845.9 851.2 857.3 858.5 859.3 908.7 910.2 910.4 912.0 919.5 754.7 913.8 916.1 918.9 920.3 658.3 679.7 684.5 685.0 685.7 16635.8 16638.1 16668.0 16695.7 16721.1 15287.5 15399.4 15650.6 15825.3 15992.4 14454.2 14526.6 14543.2 14575.2 14708.3 4672.1 4749.8 4750.1 4785.1 4835.8 84271.0 87048.6 87779.0 88946.6 90261.1 12624.2 12658.4 12771.7 12787.0 12851.7 24349.8 24576.8 24628.9 25274.7 25330.5 9437.5 9457.2 9526.4 9748.0 9811.5 5035.8 5086.2 5138.8 5181.2 5395.4 3865.1 3966.4 3973.8 3974.1 3976.4 657.9 674.2 676.4 684.3 693.6 667.0 735.7 748.2 762.5 770.3 9787.6 10206.7 10347.4 10916.9 11016.9 610.8 637.3 745.4 755.3 756.6 5127.3 5161.7 5185.5 5264.8 5447.8 75025.6 82045.6 128411.0 133671.0 139094.0 75184.2 78805.6 116552.4 116929.0 118648.0 98343.5 99462.5 100401.5 100538.0 102309.5 9242.9 9317.8 9334.8 9457.1 9517.6 48812.3 57394.7 57600.1 57687.4 57729.1 47081.5 65844.7 69209.7 70719.6 78803.2 14838.3 14872.1 14999.0 15291.6 15690.0 16220.3 17031.2 17327.2 17769.6 18620.3 15939.3 16710.7 16769.4 16864.8 17190.8 15894.4 15902.1 16269.8 16795.3 16802.8 15354.5 15582.8 16240.2 16729.9 16740.2 11930.5 11956.1 12482.8 12539.9 12866.2 12089.9 12299.3 13253.9 13461.4 13701.5 18:46:59 INFO - PROCESS | 8453 | -------- Summary: end -------- 18:46:59 INFO - PROCESS | 8453 | 18:47:00 INFO - TEST-INFO | 8453: exit 0 18:47:00 INFO - TEST-OK | dromaeo_css | took 1113646ms 18:47:00 INFO - TEST-START | kraken 18:47:00 INFO - operating with platform_type : linux_ 18:47:00 INFO - Initialising browser for kraken test... 18:47:00 INFO - TEST-INFO | started process 8658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8x_CtU/profile http://localhost:48295/getInfo.html) 18:47:04 INFO - PROCESS | 8658 | __metrics Screen width/height:1600/1200 18:47:04 INFO - PROCESS | 8658 | colorDepth:24 18:47:04 INFO - PROCESS | 8658 | Browser inner width/height: 1024/697 18:47:04 INFO - PROCESS | 8658 | __metrics 18:47:05 INFO - PROCESS | 8658 | 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" 18:47:05 INFO - PROCESS | 8658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:47:06 INFO - TEST-INFO | 8658: exit 0 18:47:06 INFO - Browser initialized. 18:47:06 INFO - Running cycle 1/1 for kraken test... 18:47:06 INFO - TEST-INFO | started process 8751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8x_CtU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:18 INFO - PROCESS | 8751 | RSS: Main: 145186816 18:47:18 INFO - PROCESS | 8751 | 18:47:20 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48295/tests/kraken/driver.html?testName=audio-beat-detection) 18:47:21 INFO - PROCESS | 8751 | RSS: Main: 190742528 18:47:21 INFO - PROCESS | 8751 | 18:47:24 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48295/tests/kraken/driver.html?testName=audio-dft) 18:47:24 INFO - PROCESS | 8751 | RSS: Main: 180633600 18:47:24 INFO - PROCESS | 8751 | 18:47:27 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48295/tests/kraken/driver.html?testName=audio-fft) 18:47:28 INFO - PROCESS | 8751 | RSS: Main: 269819904 18:47:28 INFO - PROCESS | 8751 | 18:47:30 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48295/tests/kraken/driver.html?testName=audio-oscillator) 18:47:30 INFO - PROCESS | 8751 | RSS: Main: 175095808 18:47:30 INFO - PROCESS | 8751 | 18:47:32 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:47:33 INFO - PROCESS | 8751 | RSS: Main: 177278976 18:47:33 INFO - PROCESS | 8751 | 18:47:36 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48295/tests/kraken/driver.html?testName=imaging-darkroom) 18:47:37 INFO - PROCESS | 8751 | RSS: Main: 213426176 18:47:37 INFO - PROCESS | 8751 | 18:47:40 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48295/tests/kraken/driver.html?testName=imaging-desaturate) 18:47:41 INFO - PROCESS | 8751 | RSS: Main: 212361216 18:47:41 INFO - PROCESS | 8751 | 18:47:43 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48295/tests/kraken/driver.html?testName=json-parse-financial) 18:47:44 INFO - PROCESS | 8751 | RSS: Main: 211742720 18:47:44 INFO - PROCESS | 8751 | 18:47:45 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:47:46 INFO - PROCESS | 8751 | RSS: Main: 175398912 18:47:46 INFO - PROCESS | 8751 | 18:47:48 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:47:48 INFO - PROCESS | 8751 | RSS: Main: 182153216 18:47:48 INFO - PROCESS | 8751 | 18:47:50 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:47:51 INFO - PROCESS | 8751 | RSS: Main: 186163200 18:47:51 INFO - PROCESS | 8751 | 18:47:54 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:47:54 INFO - PROCESS | 8751 | RSS: Main: 181342208 18:47:54 INFO - PROCESS | 8751 | 18:47:57 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:47:57 INFO - PROCESS | 8751 | RSS: Main: 185077760 18:47:57 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48295/tests/kraken/driver.html?testName=ai-astar) 18:47:59 INFO - PROCESS | 8751 | RSS: Main: 236257280 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | __start_tp_report 18:47:59 INFO - PROCESS | 8751 | _x_x_mozilla_page_load 18:47:59 INFO - PROCESS | 8751 | _x_x_mozilla_page_load_details 18:47:59 INFO - PROCESS | 8751 | |i|pagename|runs| 18:47:59 INFO - PROCESS | 8751 | |0;ai-astar;100;111;109;109;109;109;109;112;109;110 18:47:59 INFO - PROCESS | 8751 | |1;audio-beat-detection;145;116;124;182;116;116;153;117;170;117 18:47:59 INFO - PROCESS | 8751 | |2;audio-dft;161;162;160;160;160;161;160;160;159;161 18:47:59 INFO - PROCESS | 8751 | |3;audio-fft;75;76;75;122;75;75;74;75;110;74 18:47:59 INFO - PROCESS | 8751 | |4;audio-oscillator;84;83;117;82;82;82;113;90;82;125 18:47:59 INFO - PROCESS | 8751 | |5;imaging-gaussian-blur;119;118;118;116;117;116;117;117;116;117 18:47:59 INFO - PROCESS | 8751 | |6;imaging-darkroom;145;146;146;145;146;145;145;146;146;145 18:47:59 INFO - PROCESS | 8751 | |7;imaging-desaturate;95;95;94;95;94;95;95;94;94;94 18:47:59 INFO - PROCESS | 8751 | |8;json-parse-financial;51;50;51;49;49;49;49;48;50;49 18:47:59 INFO - PROCESS | 8751 | |9;json-stringify-tinderbox;60;62;61;60;61;59;60;60;60;60 18:47:59 INFO - PROCESS | 8751 | |10;stanford-crypto-aes;73;72;72;71;72;81;73;71;71;72 18:47:59 INFO - PROCESS | 8751 | |11;stanford-crypto-ccm;119;118;133;118;124;116;116;123;154;120 18:47:59 INFO - PROCESS | 8751 | |12;stanford-crypto-pbkdf2;146;155;150;152;149;150;154;150;154;153 18:47:59 INFO - PROCESS | 8751 | |13;stanford-crypto-sha256-iterative;63;61;62;62;64;61;61;60;60;60 18:47:59 INFO - PROCESS | 8751 | __end_tp_report 18:47:59 INFO - PROCESS | 8751 | __start_cc_report 18:47:59 INFO - PROCESS | 8751 | _x_x_mozilla_cycle_collect,1616 18:47:59 INFO - PROCESS | 8751 | __end_cc_report 18:47:59 INFO - PROCESS | 8751 | __startTimestamp1470102479713__endTimestamp 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | ------- Summary: start ------- 18:47:59 INFO - PROCESS | 8751 | Number of tests: 14 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.00 stddev:3.23 (3.0%) stddev-sans-first:1.12 18:47:59 INFO - PROCESS | 8751 | Values: 100.0 111.0 109.0 109.0 109.0 109.0 109.0 112.0 109.0 110.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:134.50 stddev:25.18 (18.7%) stddev-sans-first:26.48 18:47:59 INFO - PROCESS | 8751 | Values: 145.0 116.0 124.0 182.0 116.0 116.0 153.0 117.0 170.0 117.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 18:47:59 INFO - PROCESS | 8751 | Values: 161.0 162.0 160.0 160.0 160.0 161.0 160.0 160.0 159.0 161.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.00 stddev:17.58 (23.4%) stddev-sans-first:18.40 18:47:59 INFO - PROCESS | 8751 | Values: 75.0 76.0 75.0 122.0 75.0 75.0 74.0 75.0 110.0 74.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:82.00 stddev:17.20 (21.0%) stddev-sans-first:17.86 18:47:59 INFO - PROCESS | 8751 | Values: 84.0 83.0 117.0 82.0 82.0 82.0 113.0 90.0 82.0 125.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.99 (0.8%) stddev-sans-first:0.78 18:47:59 INFO - PROCESS | 8751 | Values: 119.0 118.0 118.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 18:47:59 INFO - PROCESS | 8751 | Values: 145.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 18:47:59 INFO - PROCESS | 8751 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:49.50 stddev:0.97 (2.0%) stddev-sans-first:0.87 18:47:59 INFO - PROCESS | 8751 | Values: 51.0 50.0 51.0 49.0 49.0 49.0 49.0 48.0 50.0 49.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 18:47:59 INFO - PROCESS | 8751 | Values: 60.0 62.0 61.0 60.0 61.0 59.0 60.0 60.0 60.0 60.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:72.00 stddev:2.97 (4.1%) stddev-sans-first:3.15 18:47:59 INFO - PROCESS | 8751 | Values: 73.0 72.0 72.0 71.0 72.0 81.0 73.0 71.0 71.0 72.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:121.50 stddev:11.66 (9.6%) stddev-sans-first:12.22 18:47:59 INFO - PROCESS | 8751 | Values: 119.0 118.0 133.0 118.0 124.0 116.0 116.0 123.0 154.0 120.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:152.50 stddev:2.79 (1.8%) stddev-sans-first:2.20 18:47:59 INFO - PROCESS | 8751 | Values: 146.0 155.0 150.0 152.0 149.0 150.0 154.0 150.0 154.0 153.0 18:47:59 INFO - PROCESS | 8751 | 18:47:59 INFO - PROCESS | 8751 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.50 stddev:1.35 (2.2%) stddev-sans-first:1.30 18:47:59 INFO - PROCESS | 8751 | Values: 63.0 61.0 62.0 62.0 64.0 61.0 61.0 60.0 60.0 60.0 18:47:59 INFO - PROCESS | 8751 | -------- Summary: end -------- 18:47:59 INFO - PROCESS | 8751 | 18:48:00 INFO - TEST-INFO | 8751: exit 0 18:48:00 INFO - TEST-OK | kraken | took 60119ms 18:48:00 INFO - SUITE-END | took 1173s 18:48:00 INFO - Completed test suite (00:19:33) 18:48:00 INFO - javascript benchmark 18:48:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3226.7257283130934, 3254.397936381769, 3265.7224135948445, 3275.0993476793865, 3314.651961544038, 5641.717914104299, 5727.942720572803, 5736.741846616902, 5757.596968212227, 5785.508231800297, 5692.544596432286, 5772.855678608037, 5773.884522309551, 5788.334341550723, 5816.621919575236, 5044.545990860822, 5156.458571849958, 5236.057509648262, 5237.162054071349, 5255.316808814849, 5218.869528261805, 5271.973640131794, 5273.472652734734, 5274.762635681384, 5286.180642000477, 5156.046131465672, 5196.766145523442, 5197.792088316482, 5214.791408343662, 5256.369235691723, 5300.575953923677, 5316.255724198615, 5326.227696983954, 5327.7336133193185, 5359.705216213107, 4995.800167993276, 5060.114479966028, 5102.336696229503, 5192.688438693691, 5198.16829307309, 5567.972160139214, 5605.243292155547, 5631.774729010835, 5638.633488823213, 5708.372079071299, 6099.225764022442, 6100.270069239556, 6100.638635718798, 6103.816885493442, 6105.847353816146, 5948.762049518057, 5981.9401805981815, 6054.576179667425, 6059.939400606026, 6114.501947023008, 5700.7719691212305, 5703.800366987136, 5711.885762284773, 5721.170430287627, 5726.2555867737765, 6207.720652570645, 6212.192414986023, 6223.066540019034, 6226.034964580497, 6226.719797609118, 5821.650700957872, 5992.850178745566, 6050.820090082391, 6062.848428789315, 6120.14317995481, 6204.410580994799, 6210.0, 6212.161358216583, 6212.192414986023, 6212.844678883064, 6114.847128821815, 6159.3224745277985, 6161.075838624242, 6169.81490555284, 6171.814845554641, 5908.0, 6001.489873360813, 6038.788642397583, 6052.939470605325, 6090.908636370458, 4661.603763680057, 4695.647826413033, 4695.835645752382, 4698.3187437821325, 4728.645351598644, 4176.791160441966, 4181.560936101666, 4190.8533201337805, 4193.266178418765, 4222.282212023963, 5667.971660141673, 5758.424157584208, 5810.331811841608, 5822.184894114827, 5895.793647222413, 6124.846878828065, 6131.437835141539, 6132.63204207749, 6138.235132557318, 6139.035508637193, 5834.562407819346, 5838.591298609056, 5840.445157710095, 5841.065429531254, 5861.150133230658, 5177.870553236199, 5257.132573125392, 5294.232336311214, 5310.522053015247, 5369.3556773187465, 6394.552381333355, 6417.647029413427, 6438.291787903327, 6454.9677251614385, 6459.870802583922, 6171.660558669137, 6212.06818977157, 6229.657368844576, 6233.688315584293, 6244.0321750128805, 6180.81457556274, 6343.90484142729, 6390.520710946605, 6390.584612000205, 6468.482521398183, 6110.908336374869, 6117.724702388492, 6118.755249789959, 6121.32665406796, 6123.601965872204, 6225.470834979077, 6228.159198508143, 6232.937670623417, 6234.875302494015, 6235.189425374853, 5832.94167058324, 5874.324452687995, 5893.764249429974, 5896.852578685395, 5981.850453738692, 5907.940920590739, 5946.732397042057, 5948.910766338595, 5958.314793798769, 5965.045592705146, 5862.443067908542, 5874.618149820248, 5875.236219291465, 5915.0, 5937.0, 5834.82495525118, 6014.609050411709, 6092.888142585961, 6117.082437634391, 6118.235220597426, 5924.289085309791, 5947.732352044255, 5951.494122999594, 5954.672493012926, 5956.285245770535], "value": 5650.633585452805, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.9606125601836, 616.5776443136451, 638.4509321983095, 643.8519140597663, 660.791850567071, 35302.99999999997, 47358.0, 48517.331546764915, 48600.75699621497, 48674.51325486744, 49506.25740613894, 49934.750326248315, 49936.75031624846, 50046.74976625121, 50109.749451252785, 8382.87425688615, 9282.0, 9422.481763503005, 9476.336656434052, 11088.002079812815, 10954.507047182857, 11436.656900292963, 11441.713957151054, 11444.599439019636, 11454.312741235553, 11467.483963221675, 11536.0, 11537.884621153808, 11539.884601153964, 11542.596009139681, 11455.885441145607, 11481.598144064918, 11504.0, 11504.884951150465, 11513.481893314822, 11308.604198853083, 11330.71673208168, 11355.261907975955, 11395.829062564067, 11403.0, 46668.53331466676, 47061.52938470606, 47182.05635887297, 47252.0, 47260.527394725956, 3929.0373858404587, 4124.752514849089, 4242.045539753562, 4304.332828411601, 4627.676062675614, 35269.82365088184, 35472.29055418903, 35510.28979420423, 35882.10294742626, 37480.437793432844, 3778.886633401002, 3874.6900247980375, 3898.2203559288255, 3911.5892831252595, 3982.163745613396, 384240.0, 385199.0, 387165.0, 388885.0, 390623.0, 35844.0, 36905.63094369022, 36906.63093369032, 39017.0, 65781.6710916452, 39840.203195935916, 39926.0, 39944.60055399467, 39951.40072898909, 39956.80021599874, 17038.914805425895, 17392.47822565325, 17436.215370308368, 17461.126943652765, 17465.7380139298, 12478.563250286197, 12530.185537940004, 13008.0, 13169.934150329187, 14143.222122783345, 9214.815703686023, 9317.347785655074, 9342.0, 9386.671466498776, 9402.764930876647, 3518.648135186461, 3518.964810351864, 3539.752217344813, 3551.2542366103407, 3628.963710362915, 1086.6631344283298, 1114.9944250278697, 1147.4205526209378, 1234.9876501235053, 1237.826704261404, 35926.281474370364, 36562.451563226576, 36854.81572592173, 36900.815495922885, 36975.63024369776, 1123.662901129658, 1175.6884425627215, 1235.7827539873217, 1247.1581682364367, 1254.404158024949, 18894.426144287194, 18908.43274701761, 19145.904270478557, 19239.90380048119, 19243.0, 599091.0, 600500.0, 603558.0, 604620.8382706584, 604622.0, 66083.0, 66521.0, 66635.0, 66725.0, 66826.66586667036, 1343.737971095627, 1441.2001339256603, 1484.829244636859, 1500.8349081601016, 1502.1662977047843, 35295.647043529236, 37150.44274335941, 37448.2510349786, 37554.62445375621, 37671.623283766814, 53957.190642141184, 54063.18905216346, 55615.0, 55662.72168639293, 61499.6925015372, 556655.0, 560712.0, 561507.0, 561882.0, 563490.0, 31185.8440707795, 31546.36907261796, 31553.842230788698, 33303.50044749282, 49379.753101234266, 52934.73532632312, 53570.73214633902, 53651.46348536465, 53663.463365365846, 53974.73012634912, 44867.55132448634, 45668.314975274734, 46032.0, 46324.7683761579, 47333.29000064933, 44414.0, 45848.312275316566, 46338.0, 46769.0, 46894.29658555193, 45642.31536527021, 46385.0, 46910.765446173915, 49007.50992490172, 49628.25557616566, 39332.80333598314, 40715.38926916039, 40736.0, 40898.0, 40987.59012409957, 30976.380472390876, 31127.37745245037, 31175.84412077925, 31402.0, 31560.36879262448], "value": 21169.04763841, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.26666400495094, 419.91312806387305, 434.91301739652073, 439.7823077576599, 442.307788311293, 16079.919600401996, 20538.383848484533, 20549.280775172854, 20590.897045514772, 21446.463838404008, 20139.395818125442, 20285.0, 20359.796402035976, 20432.795672043314, 20592.691109633368, 4122.0931395093185, 5747.080467125261, 5779.595428320019, 5861.150133230679, 6028.21633187685, 5972.492338151263, 6013.759449622032, 6083.0, 6083.908741368883, 6097.146399504073, 5718.08510638298, 5954.2259506264345, 5984.162217289583, 6076.301225359074, 6084.96957515214, 6025.969870150621, 6035.094735789623, 6055.000924847395, 6065.605735627192, 6071.787487437962, 5768.509676677488, 5907.202527658754, 5994.460498555151, 5997.910031349533, 6000.159977603139, 14610.488632897905, 14647.70704585913, 14713.264336783224, 14780.408783648749, 14893.255337233095, 2390.3546042568582, 2558.60341647045, 2716.0358072884237, 2767.9446411071867, 2960.008397186945, 10672.733181670443, 11336.263142895685, 13238.007149463732, 15063.623409414853, 15418.074915504993, 2015.304719871642, 2023.5447024419534, 2039.7450318710162, 2088.644930361827, 2098.821600163988, 84281.57859210727, 85257.57371213104, 86459.0, 87924.0, 88714.55642721745, 11471.967522922978, 11518.539258429737, 11886.643400697993, 11929.880701193051, 11976.940115299367, 16201.189940503164, 16223.026618402697, 16243.756343654855, 16272.674546509004, 16293.837061629232, 8486.405951583454, 8742.269677297756, 8802.33982451306, 8959.059298773665, 9056.04911484298, 8701.651933922698, 8851.734447966572, 8894.688685896092, 9088.272938165062, 9110.772230694152, 4564.2240819060835, 4900.705957642553, 5060.544550990428, 5068.9375506893875, 5195.688258704414, 1935.332310352926, 2059.567490826913, 2069.751629804403, 2133.871967681944, 2137.3053757528555, 971.3977334052933, 1063.7925604507202, 1087.1628845788857, 1115.11905594581, 1171.543098191706, 20535.691964620542, 20610.896945515477, 20702.171913123308, 20940.685889711665, 21007.579848403253, 1027.6043723166636, 1033.2715435617872, 1033.8914413986574, 1046.8063408269495, 1056.9735756606146, 10829.776674937966, 11649.650510484698, 11678.824817627743, 11706.765864682659, 11717.414129293502, 512282.0, 523702.0, 525418.0, 530936.0, 538028.0, 93397.0, 95150.52424737831, 95302.0, 97678.0, 99670.0, 980.1472718734603, 1022.1618273016204, 1030.8247597908373, 1056.028453822485, 1057.080340104099, 17936.820631793515, 18160.0, 18508.9820059898, 18680.0, 18717.906410467862, 45751.77124114358, 46119.538804612865, 46330.07339853117, 46834.53165468438, 47787.522124778305, 61401.0, 63145.36854631395, 63627.6818615904, 64013.0, 64271.35728642654, 5359.035373632783, 6769.8491256487505, 8163.428560000743, 8578.78553036179, 8882.822343552964, 11770.646880593597, 13534.86465135336, 13577.32113394346, 13778.793318100035, 14111.717765644835, 11690.415479226174, 11864.0, 11936.641900742645, 12125.514979400725, 12369.814452783396, 11777.352245626573, 11938.64184074479, 12006.519739210335, 12066.457009434422, 12201.145919785884, 12054.638360849189, 12085.577004804789, 12134.514619415124, 12193.69515762113, 12533.74932501363, 8717.476951382938, 8801.427907186013, 8897.510636915033, 8950.910490895008, 9004.59479323419, 10782.784344312913, 11052.557897684002, 11905.761884762083, 11956.76086478283, 12183.573574924834], "value": 9613.866867189916, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.5676575410266, 1517.051842598376, 1607.1321486397346, 1769.7079981803004, 1913.512054426121, 9359.81280374393, 9655.758606034853, 9773.755656108591, 10105.545250463729, 10159.796804063913, 9909.355891867024, 10029.498525073754, 10064.949675251632, 10068.395896246231, 10071.244656650744, 2396.928092157238, 2423.4789520253144, 2425.733169351379, 2429.392651837041, 2429.6112621980396, 2408.494216214597, 2412.4089598048504, 2442.426029882976, 2446.8898899549563, 2448.179859746987, 2421.1889017179265, 2441.1944058460754, 2446.290575733044, 2450.13020377766, 2451.0, 2387.3196139100446, 2388.9641655375185, 2398.0767404549288, 2398.412388964706, 2422.8667423291713, 2362.2204672458047, 2364.9763502364926, 2365.7161140663056, 2366.8934897929635, 2369.845960012594, 9685.6610018649, 10006.09945104944, 10058.295919285652, 10064.194864410829, 10073.395596264247, 5900.852478688067, 5989.730462129171, 5991.0, 6046.09308603713, 6063.878722425571, 3640.5449318835144, 3696.537932758405, 3770.6794922431627, 3772.6981841452894, 3781.3382658035007, 1133.4955944604653, 1141.2809929744208, 1144.096164030415, 1163.9301641901513, 1171.1567671276753, 14379.209143497104, 14485.42058317666, 14522.128672279803, 14522.636934076627, 14558.199299038548, 4956.355673762388, 5010.498950105033, 5049.2426136079885, 5088.185890257541, 5193.169092945186, 11115.777684446428, 11152.996230339308, 11154.330740155616, 11157.38634375101, 11160.386178760245, 5832.24180856486, 5835.328937172279, 5840.561957853093, 5852.736626851802, 5857.0, 4866.148424025781, 4872.561469467765, 5368.624196306299, 5423.701696406735, 5450.400455949843, 4178.644815190682, 4194.42708984131, 4224.091820258659, 4287.442632457761, 4290.849820256276, 1235.199713807304, 1271.7456508698297, 1284.3321472834075, 1290.587012156101, 1297.1179597873536, 1060.984085238722, 1082.767205050918, 1098.1763677242068, 1104.2877344113, 1118.2340097033557, 6775.254721980578, 6908.620025898524, 6959.582425054412, 7021.859562808715, 7115.146182458035, 466.8856130248111, 489.43714728062304, 501.45341577680506, 501.92471129330164, 503.02915373329097, 4804.73573953429, 4810.927836082462, 4837.346958160603, 4884.780184891689, 4885.340479035356, 12568.560100396626, 12964.157329773534, 13025.674358141123, 13072.673183170307, 13074.346282685829, 12451.315177665134, 12647.114701970773, 12910.096293259381, 12913.741725165444, 12919.031072669588, 9347.672831450867, 9411.20004799586, 9448.48033358172, 9469.289803264921, 9543.379680320757, 6626.867462650816, 6887.552309099892, 6889.586624802528, 6913.10129683138, 6954.443644508326, 11759.941200293944, 11798.528058877891, 11819.11356648272, 11872.406379680808, 11930.761384772082, 11735.23720958135, 11878.0, 11983.940080299542, 12055.276683399024, 12132.636020919386, 8452.704155354533, 8575.056743758307, 8632.91367086321, 8648.04871464151, 8660.220580147818, 9655.565499552396, 9712.0, 9780.315377923476, 9780.755481113029, 9800.460974646463, 8328.708495202882, 8521.147885211429, 8553.44402613828, 8624.223819856243, 8790.648374064966, 8575.31397488187, 8686.261667758312, 8718.782030449036, 8866.60100295501, 8926.86609700842, 8082.87875681877, 8193.057798353027, 8194.83610327802, 8198.918010819816, 8199.467034642728, 5787.276590426197, 5800.970995145166, 5867.354590995073, 5869.06095024794, 6030.065339872327, 5643.689597072201, 5777.7977770777825, 5784.768609255582, 6069.726862291119, 6069.757209711562], "value": 5059.799774629328, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.6269235956066, 353.6799196726963, 361.28645924299514, 361.7124386113041, 364.61350967973965, 5487.231787549741, 5492.945070549294, 5543.946650136481, 5548.334199896008, 5577.972110139453, 5387.515123638872, 5451.700156491392, 5486.177073438987, 5491.780328786854, 5495.807646732365, 4190.7066505344565, 4317.935230971538, 4340.631046361063, 4349.913001739963, 4369.213541562517, 4289.678274129437, 4290.42079319291, 4335.111302183045, 4335.653147748172, 4336.21948049351, 4042.0501182222156, 4283.121959998193, 4305.698601097924, 4324.502682191541, 4343.4363629093505, 4096.938545921814, 4216.156768646252, 4255.127698821734, 4267.8079486423185, 4298.226319262531, 3821.14024344523, 3824.4454554089502, 3827.827747751358, 3833.8274777634792, 3835.7314987950854, 5059.723124593911, 5297.337832770903, 5306.52241298285, 5312.601554883399, 5357.1696387060065, 4539.114872599845, 4832.9459979508565, 4853.635977301717, 4879.951200487985, 4883.12103821312, 5636.520895723868, 5650.604457687963, 5659.349174844863, 5664.178694089334, 5696.629719068247, 4053.067794407273, 4174.895627609304, 4185.22573323936, 4188.099558594886, 4193.071187253867, 5843.240378750777, 5859.29688437386, 5862.768818548067, 5872.677002764846, 5906.527477801808, 4264.360345948133, 4274.482558691682, 4302.827886884552, 4314.546972567898, 4315.09383029561, 4270.551592082787, 4363.083752411965, 4365.454318210223, 4370.191514569815, 4376.3654270130655, 4865.610751139971, 4868.123737727243, 4872.78072486739, 4911.45973942866, 4962.354893863775, 5679.807240479463, 5683.687397193194, 5720.913026524947, 5762.1068734346245, 5789.507891829242, 1450.6228380621114, 1481.4296495849176, 1492.6492274315526, 1501.81978162619, 1507.8718308943644, 941.2093841173447, 964.864918911353, 976.9951150244345, 982.0523195116747, 983.6704703924122, 4865.270209468537, 4894.1679914414635, 4919.458859525449, 4926.482719314492, 4955.925661115014, 5093.617978651542, 5101.744912754348, 5106.234064890222, 5144.71704056273, 5159.277701121846, 4936.802527898915, 4949.515145456421, 5065.965125035478, 5338.3060202173465, 5481.643693159932, 2998.3553535989868, 3025.878964841426, 3026.3947210557976, 3083.7070478304527, 3084.0901933929545, 6070.848228794227, 6074.20362273579, 6081.148639190517, 6091.964366057781, 6092.786752463731, 5718.428157184331, 5978.192943952511, 5983.128098512739, 6022.307434644984, 6034.758609655652, 6110.816675499742, 6111.258291386934, 6131.662758548234, 6146.170267013986, 6150.661713605705, 5646.689432081275, 5884.852878678067, 5904.498117660047, 5907.940920590911, 5909.349971503045, 5837.5329973601165, 5840.474357307863, 5851.941480585139, 5860.208871802422, 5861.35525092248, 6098.359672234352, 6104.298005729398, 6112.113743507255, 6123.326434092157, 6127.3259941407305, 4021.798910054427, 4174.20690068886, 4207.4109624651965, 4224.486430573804, 4236.851710190129, 5872.941270587239, 5913.793017244548, 5916.994111001054, 5927.0, 5959.22530071088, 5695.724958149163, 5793.333766616893, 5806.854828629318, 5818.33089194748, 5860.8571328592225, 5742.626729262584, 5746.655200687972, 5752.252207213203, 5755.769769209185, 5763.308402991668, 5481.917771233514, 5604.271444712162, 5708.343540492897, 5726.770929162787, 5751.396103409082, 5654.943450565606, 5784.0, 5807.361190269152, 5813.302403711582, 5824.126381042877, 5652.378238393691, 5653.745581448927, 5662.320521537277, 5674.893395787947, 5683.8863222736145], "value": 4357.218629791951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.6812668564392, 792.413613925695, 797.2585495489196, 806.2501873257871, 880.9471431714094, 17088.145592720375, 18290.451286461393, 18315.633687326244, 18317.908410457945, 18346.449606511793, 16153.273102710376, 16493.34026638933, 16526.25631846567, 16578.253978570963, 16611.41860034899, 710.2897102897103, 819.1644522586957, 843.5908584336592, 845.9788505287355, 860.9225169734739, 845.9323254139654, 851.199872120205, 857.3269983063296, 858.4505916213628, 859.325429537813, 908.7319240823973, 910.1581037540282, 910.3763921713614, 911.9740292171307, 919.4896832258094, 754.7396148328872, 913.7852604637905, 916.083916083916, 918.9310801689867, 920.2913756407562, 658.3383699382139, 679.7281087564965, 684.5208354152113, 684.9828754281133, 685.6811582614108, 16635.750463743054, 16638.0849053302, 16668.0, 16695.74956375655, 16721.080340581262, 15287.541373758804, 15399.384024639001, 15650.608734781608, 15825.28786204612, 15992.36030558788, 14454.205018723966, 14526.636834079232, 14543.200123993176, 14575.19836408997, 14708.33812478441, 4672.0889426561835, 4749.810007599692, 4750.12122757291, 4785.138675038526, 4835.758212089417, 84271.0, 87048.5647571758, 87779.0, 88946.55526722454, 90261.09738902592, 12624.17942833713, 12658.367081645882, 12771.744565108645, 12787.0, 12851.742965140646, 24349.756502435102, 24576.754232457446, 24628.876855615606, 25274.747252527606, 25330.493390132462, 9437.480938548446, 9457.24342052648, 9526.428414295164, 9748.0, 9811.509424528887, 5035.84892453227, 5086.237064440364, 5138.845834624967, 5181.171012637959, 5395.3525576931015, 3865.0530619997717, 3966.4446977423186, 3973.7814420206587, 3974.066094467798, 3976.363781794899, 657.9407853293227, 674.1707699529607, 676.35746041261, 684.288340126273, 693.6219760230687, 667.0, 735.6873328835223, 748.1657951384168, 762.5158024654385, 770.3336613828998, 9787.608495660093, 10206.746680489765, 10347.4308913009, 10916.890831091747, 11016.889831101747, 610.7866101343152, 637.3276193615687, 745.4446437404168, 755.3126654744157, 756.5574139128562, 5127.2857655073085, 5161.716105614228, 5185.533302002837, 5264.842054738364, 5447.782088716407, 75025.62487187529, 82045.58977205076, 128411.0, 133671.0, 139094.0, 75184.24815751881, 78805.60597196977, 116552.41723791327, 116929.0, 118648.0, 98343.50828245813, 99462.50268748609, 100401.49799251102, 100538.0, 102309.48845255875, 9242.907570924204, 9317.813643727222, 9334.813303733752, 9457.131082013806, 9517.588691381472, 48812.2678159835, 57394.7130264346, 57600.135997960904, 57687.423125768204, 57729.13406298825, 47081.52918470772, 65844.67077664581, 69209.65395172992, 70719.64640176766, 78803.21196787959, 14838.258087095817, 14872.107673539622, 14999.0, 15291.61770955735, 15690.0, 16220.27008784584, 17031.23359448803, 17327.2202750874, 17769.555761106076, 18620.255189792257, 15939.282732276843, 16710.66578668444, 16769.413070542472, 16864.83135168682, 17190.828091718922, 15894.364225430852, 15902.125383104041, 16269.75595366094, 16795.32818687239, 16802.831971680127, 15354.539363819104, 15582.766258506359, 16240.18799060066, 16729.91635041817, 16740.24668889927, 11930.522779088738, 11956.06273629199, 12482.812757808459, 12539.93730031344, 12866.163699359511, 12089.879101208875, 12299.262044277371, 13253.867461325262, 13461.394237259543, 13701.45194192221], "value": 8310.38690601757, "unit": "score"}], "name": "dromaeo_css", "value": 7714.074590757755, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 109.0, 109.0, 109.0, 109.0, 109.0, 112.0, 109.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 124.0, 182.0, 116.0, 116.0, 153.0, 117.0, 170.0, 117.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 160.0, 161.0, 160.0, 160.0, 159.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 122.0, 75.0, 75.0, 74.0, 75.0, 110.0, 74.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 117.0, 82.0, 82.0, 82.0, 113.0, 90.0, 82.0, 125.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 49.0, 49.0, 49.0, 49.0, 48.0, 50.0, 49.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 60.0, 61.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 71.0, 72.0, 81.0, 73.0, 71.0, 71.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 133.0, 118.0, 124.0, 116.0, 116.0, 123.0, 154.0, 120.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 155.0, 150.0, 152.0, 149.0, 150.0, 154.0, 150.0, 154.0, 153.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 62.0, 64.0, 61.0, 61.0, 60.0, 60.0, 60.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1458.3, "alertThreshold": 2.0}]} 18:48:00 INFO - Return code: 0 18:48:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:48:01 INFO - # TBPL SUCCESS # 18:48:01 INFO - Running post-action listener: _resource_record_post_action 18:48:01 INFO - [mozharness: 2016-08-02 01:48:01.002078Z] Finished run-tests step (success) 18:48:01 INFO - Running post-run listener: _resource_record_post_run 18:48:01 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 526213120; Read time: 8; Write time: 671420 18:48:01 INFO - TinderboxPrint: CPU usage
13.0% 18:48:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:48:01 INFO - TinderboxPrint: I/O write bytes / time
526,213,120 / 671,420 18:48:01 INFO - TinderboxPrint: CPU idle
8,265.8 (87.0%) 18:48:01 INFO - TinderboxPrint: CPU user
1,183.7 (12.5%) 18:48:01 INFO - TinderboxPrint: Swap in / out
0 / 0 18:48:01 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 251572224; Read time: 0; Write time: 402800 18:48:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 254234624; Read time: 0; Write time: 262832 18:48:01 INFO - Running post-run listener: _upload_blobber_files 18:48:01 INFO - Blob upload gear active. 18:48:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:48:01 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 18:48:01 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'] 18:48:01 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 18:48:02 INFO - (blobuploader) - INFO - Open directory for files ... 18:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:48:05 INFO - (blobuploader) - INFO - Done attempting. 18:48:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:48:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:48:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:48:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:48:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:48:06 INFO - (blobuploader) - INFO - Done attempting. 18:48:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:48:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:48:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:48:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:48:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:48:07 INFO - (blobuploader) - INFO - Done attempting. 18:48:07 INFO - (blobuploader) - INFO - Iteration through files over. 18:48:07 INFO - Return code: 0 18:48:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:48:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:48:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80d3415c39f4e12ac20282dce06ac8f5c06ab0277d5d39bc606b961331bef6473b1fbf192d39d412708637ec855e28002c4ddeddc7b582842e122180de561b3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e2e2f18fa0838d0484abf5a1c0309da1598f737f9ee3e7e62c42e46c98e4acee7979208f0b0333aa5a4cac884efeb58df4978cad8191c5e122d0cc6a8bf4001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09a8c92dc2b9743b66752e03adb2926cf1bf642d27cd6d284ad1f9d7265bbeb069fd776d8fc11649c7316a1c5404cd810d893a9ff0eeb47ade9b52d87b130758"} 18:48:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:48:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:48:07 INFO - Contents: 18:48:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80d3415c39f4e12ac20282dce06ac8f5c06ab0277d5d39bc606b961331bef6473b1fbf192d39d412708637ec855e28002c4ddeddc7b582842e122180de561b3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e2e2f18fa0838d0484abf5a1c0309da1598f737f9ee3e7e62c42e46c98e4acee7979208f0b0333aa5a4cac884efeb58df4978cad8191c5e122d0cc6a8bf4001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09a8c92dc2b9743b66752e03adb2926cf1bf642d27cd6d284ad1f9d7265bbeb069fd776d8fc11649c7316a1c5404cd810d893a9ff0eeb47ade9b52d87b130758"} 18:48:07 INFO - Running post-run listener: copy_logs_to_upload_dir 18:48:07 INFO - Copying logs to upload dir... 18:48:07 INFO - mkdir: /builds/slave/test/build/upload/logs 18:48:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.690686 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-01 18:48:07.222925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 18:48:07.226724) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136 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/80d3415c39f4e12ac20282dce06ac8f5c06ab0277d5d39bc606b961331bef6473b1fbf192d39d412708637ec855e28002c4ddeddc7b582842e122180de561b3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e2e2f18fa0838d0484abf5a1c0309da1598f737f9ee3e7e62c42e46c98e4acee7979208f0b0333aa5a4cac884efeb58df4978cad8191c5e122d0cc6a8bf4001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09a8c92dc2b9743b66752e03adb2926cf1bf642d27cd6d284ad1f9d7265bbeb069fd776d8fc11649c7316a1c5404cd810d893a9ff0eeb47ade9b52d87b130758"} build_url:https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/a9ArChShSSqgBAYB7_YytQ/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/80d3415c39f4e12ac20282dce06ac8f5c06ab0277d5d39bc606b961331bef6473b1fbf192d39d412708637ec855e28002c4ddeddc7b582842e122180de561b3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e2e2f18fa0838d0484abf5a1c0309da1598f737f9ee3e7e62c42e46c98e4acee7979208f0b0333aa5a4cac884efeb58df4978cad8191c5e122d0cc6a8bf4001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09a8c92dc2b9743b66752e03adb2926cf1bf642d27cd6d284ad1f9d7265bbeb069fd776d8fc11649c7316a1c5404cd810d893a9ff0eeb47ade9b52d87b130758"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 18:48:07.252019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 18:48:07.252327) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470101256.13741-178947136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 18:48:07.338290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 18:48:07.338651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 18:48:07.338945) ========= ========= Total master_lag: 0.15 =========