builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1470082300.27 results: success (0) buildid: 20160801100441 builduid: dff5b688c76c4f79ad71bd5b2430d5b4 revision: cace1687008bb7f514b76017f62895c23ec18c2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:40.269001) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:40.269490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:40.269780) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:40.285139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:40.285467) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 13:11:40-- 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% 103M=0s 2016-08-01 13:11:40 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:40.431699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:40.432020) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020646 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:40.482027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 13:11:40.482416) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cace1687008bb7f514b76017f62895c23ec18c2c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cace1687008bb7f514b76017f62895c23ec18c2c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 13:11:41,097 truncating revision to first 12 chars 2016-08-01 13:11:41,097 Setting DEBUG logging. 2016-08-01 13:11:41,097 attempt 1/10 2016-08-01 13:11:41,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cace1687008b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 13:11:41,889 unpacking tar archive at: mozilla-aurora-cace1687008b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.132691 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 13:11:41.629259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:41.629591) ========= script_repo_revision: cace1687008bb7f514b76017f62895c23ec18c2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:41.629997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:41.630296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 13:11:41.641040) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-08-01 13:11:41.641474) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:11:42 INFO - MultiFileLogger online at 20160801 13:11:42 in /builds/slave/test 13:11:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:11:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:11:42 INFO - {'append_to_log': False, 13:11:42 INFO - 'base_work_dir': '/builds/slave/test', 13:11:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:11:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:11:42 INFO - 'branch': 'Mozilla-Aurora', 13:11:42 INFO - 'buildbot_json_path': 'buildprops.json', 13:11:42 INFO - 'config_files': ('talos/linux_config.py',), 13:11:42 INFO - 'default_actions': ('clobber', 13:11:42 INFO - 'read-buildbot-config', 13:11:42 INFO - 'download-and-extract', 13:11:42 INFO - 'populate-webroot', 13:11:42 INFO - 'create-virtualenv', 13:11:42 INFO - 'install', 13:11:42 INFO - 'run-tests'), 13:11:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:11:42 INFO - 'download_minidump_stackwalk': True, 13:11:42 INFO - 'download_symbols': 'ondemand', 13:11:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:11:42 INFO - 'tooltool.py': '/tools/tooltool.py', 13:11:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:11:42 INFO - '/tools/misc-python/virtualenv.py')}, 13:11:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:11:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:11:42 INFO - 'installer_path': 'installer.exe', 13:11:42 INFO - 'log_level': 'info', 13:11:42 INFO - 'log_name': 'talos', 13:11:42 INFO - 'log_to_console': True, 13:11:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:11:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:11:42 INFO - 'opt_config_files': (), 13:11:42 INFO - 'pip_index': False, 13:11:42 INFO - 'sps_profile': False, 13:11:42 INFO - 'sps_profile_interval': 0, 13:11:42 INFO - 'suite': 'dromaeojs', 13:11:42 INFO - 'system_bits': '32', 13:11:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:11:42 INFO - 'title': 'talos-linux64-ix-013', 13:11:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:11:42 INFO - 'use_talos_json': True, 13:11:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:11:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:11:42 INFO - 'work_dir': 'build'} 13:11:42 INFO - [mozharness: 2016-08-01 20:11:42.347717Z] Running clobber step. 13:11:42 INFO - Running pre-action listener: _resource_record_pre_action 13:11:42 INFO - Running main action method: clobber 13:11:42 INFO - rmtree: /builds/slave/test/build 13:11:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:11:42 INFO - Running post-action listener: _resource_record_post_action 13:11:42 INFO - [mozharness: 2016-08-01 20:11:42.812742Z] Finished clobber step (success) 13:11:42 INFO - [mozharness: 2016-08-01 20:11:42.812843Z] Running read-buildbot-config step. 13:11:42 INFO - Running pre-action listener: _resource_record_pre_action 13:11:42 INFO - Running main action method: read_buildbot_config 13:11:42 INFO - Using buildbot properties: 13:11:42 INFO - { 13:11:42 INFO - "project": "", 13:11:42 INFO - "product": "firefox", 13:11:42 INFO - "script_repo_revision": "production", 13:11:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:11:42 INFO - "repository": "", 13:11:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:11:42 INFO - "buildid": "20160801100441", 13:11:42 INFO - "pgo_build": "True", 13:11:42 INFO - "basedir": "/builds/slave/test", 13:11:42 INFO - "buildnumber": 407, 13:11:42 INFO - "slavename": "talos-linux64-ix-013", 13:11:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:11:42 INFO - "platform": "ubuntu64_hw", 13:11:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:11:42 INFO - "branch": "mozilla-aurora", 13:11:42 INFO - "repo_path": "releases/mozilla-aurora", 13:11:42 INFO - "revision": "cace1687008bb7f514b76017f62895c23ec18c2c", 13:11:42 INFO - "stage_platform": "linux64-pgo", 13:11:42 INFO - "builduid": "dff5b688c76c4f79ad71bd5b2430d5b4", 13:11:42 INFO - "slavebuilddir": "test" 13:11:42 INFO - } 13:11:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 13:11:42 INFO - Running post-action listener: _resource_record_post_action 13:11:42 INFO - [mozharness: 2016-08-01 20:11:42.815305Z] Finished read-buildbot-config step (success) 13:11:42 INFO - [mozharness: 2016-08-01 20:11:42.815394Z] Running download-and-extract step. 13:11:42 INFO - Running pre-action listener: _resource_record_pre_action 13:11:42 INFO - Running main action method: download_and_extract 13:11:42 INFO - mkdir: /builds/slave/test/build/tests 13:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:42 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:11:43 INFO - Downloaded 1361 bytes. 13:11:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:11:43 INFO - Using the following test package requirements: 13:11:43 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:11:43 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:11:43 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:11:43 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:43 INFO - u'jsshell-linux-x86_64.zip'], 13:11:43 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:11:43 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:11:43 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:11:43 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:11:43 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:11:43 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:11:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:11:43 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:43 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:11:44 INFO - Downloaded 21764987 bytes. 13:11:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:11:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:11:45 INFO - Return code: 0 13:11:45 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:45 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:11:46 INFO - Downloaded 21764987 bytes. 13:11:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:11:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:11:48 INFO - Return code: 0 13:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:48 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:11:48 INFO - Downloaded 14413723 bytes. 13:11:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:11:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:11:49 INFO - Return code: 0 13:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:49 INFO - https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:11:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:11:50 INFO - Downloaded 63777811 bytes. 13:11:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:50 INFO - mkdir: /builds/slave/test/properties 13:11:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:11:50 INFO - Writing to file /builds/slave/test/properties/build_url 13:11:50 INFO - Contents: 13:11:50 INFO - build_url:https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:11:51 INFO - Running post-action listener: _resource_record_post_action 13:11:51 INFO - Running post-action listener: set_extra_try_arguments 13:11:51 INFO - [mozharness: 2016-08-01 20:11:51.141434Z] Finished download-and-extract step (success) 13:11:51 INFO - [mozharness: 2016-08-01 20:11:51.141669Z] Running populate-webroot step. 13:11:51 INFO - Running pre-action listener: _resource_record_pre_action 13:11:51 INFO - Running main action method: populate_webroot 13:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:11:51 INFO - '--tppagecycles', 13:11:51 INFO - '7'], 13:11:51 INFO - 'tests': ['tsvgm']}}, 13:11:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:11:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:11:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:11:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:11:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:51 INFO - 'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:51 INFO - 'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['damp', 'tps']}, 13:11:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:51 INFO - 'tests': ['damp', 'tps']}, 13:11:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['dromaeo_dom']}, 13:11:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:11:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['basic_compositor_video']}, 13:11:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:11:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other-e10s': {'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['tsvgx', 13:11:51 INFO - 'tsvgr_opacity', 13:11:51 INFO - 'tart', 13:11:51 INFO - 'tscrollx', 13:11:51 INFO - 'cart']}, 13:11:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:11:51 INFO - 'tsvgr_opacity', 13:11:51 INFO - 'tart', 13:11:51 INFO - 'tscrollx', 13:11:51 INFO - 'cart']}, 13:11:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:51 INFO - 'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['tp5o']}, 13:11:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:51 INFO - 'tests': ['tp5o']}, 13:11:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:51 INFO - 'talos_options': ['--disable-e10s', 13:11:51 INFO - '--xperf_path', 13:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:51 INFO - 'tests': ['tp5n']}, 13:11:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:51 INFO - 'talos_options': ['--xperf_path', 13:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:51 INFO - 'tests': ['tp5n']}}, 13:11:51 INFO - 'talos.zip': {'path': '', 13:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:11:51 INFO - Running post-action listener: _resource_record_post_action 13:11:51 INFO - [mozharness: 2016-08-01 20:11:51.162959Z] Finished populate-webroot step (success) 13:11:51 INFO - [mozharness: 2016-08-01 20:11:51.163048Z] Running create-virtualenv step. 13:11:51 INFO - Running pre-action listener: _resource_record_pre_action 13:11:51 INFO - Running main action method: create_virtualenv 13:11:51 INFO - Creating virtualenv /builds/slave/test/build/venv 13:11:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:11:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:11:51 INFO - Using real prefix '/usr' 13:11:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:11:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:11:53 INFO - Installing pip.................done. 13:11:53 INFO - Return code: 0 13:11:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:11: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')]} 13:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11: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')]} 13:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11: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', 'pip>=1.5'] in /builds/slave/test/build 13:11: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 pip>=1.5 13:11:53 INFO - Using env: {'DISPLAY': ':0', 13:11:53 INFO - 'HOME': '/home/cltbld', 13:11:53 INFO - 'LANG': 'en_US.UTF-8', 13:11:53 INFO - 'LANGUAGE': 'en_US:en', 13:11:53 INFO - 'LOGNAME': 'cltbld', 13:11:53 INFO - 'MAIL': '/var/mail/cltbld', 13:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:53 INFO - 'MOZ_NO_REMOTE': '1', 13:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:53 INFO - 'NO_EM_RESTART': '1', 13:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:53 INFO - 'PWD': '/builds/slave/test', 13:11:53 INFO - 'SHELL': '/bin/bash', 13:11:53 INFO - 'SHLVL': '1', 13:11:53 INFO - 'TERM': 'linux', 13:11:53 INFO - 'TMOUT': '86400', 13:11:53 INFO - 'USER': 'cltbld', 13:11:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:53 INFO - '_': '/tools/buildbot/bin/python'} 13:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:11:53 INFO - Cleaning up... 13:11:54 INFO - Return code: 0 13:11:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:11:54 INFO - Using env: {'DISPLAY': ':0', 13:11:54 INFO - 'HOME': '/home/cltbld', 13:11:54 INFO - 'LANG': 'en_US.UTF-8', 13:11:54 INFO - 'LANGUAGE': 'en_US:en', 13:11:54 INFO - 'LOGNAME': 'cltbld', 13:11:54 INFO - 'MAIL': '/var/mail/cltbld', 13:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:54 INFO - 'MOZ_NO_REMOTE': '1', 13:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:54 INFO - 'NO_EM_RESTART': '1', 13:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:54 INFO - 'PWD': '/builds/slave/test', 13:11:54 INFO - 'SHELL': '/bin/bash', 13:11:54 INFO - 'SHLVL': '1', 13:11:54 INFO - 'TERM': 'linux', 13:11:54 INFO - 'TMOUT': '86400', 13:11:54 INFO - 'USER': 'cltbld', 13:11:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:54 INFO - '_': '/tools/buildbot/bin/python'} 13:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:54 INFO - Downloading/unpacking psutil>=3.1.1 13:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:56 INFO - Installing collected packages: psutil 13:11:56 INFO - Running setup.py install for psutil 13:11:56 INFO - building 'psutil._psutil_linux' extension 13:11:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:11:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:11:56 INFO - building 'psutil._psutil_posix' extension 13:11:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:11:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:56 INFO - Successfully installed psutil 13:11:56 INFO - Cleaning up... 13:11:56 INFO - Return code: 0 13:11:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:56 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 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:11:56 INFO - Using env: {'DISPLAY': ':0', 13:11:56 INFO - 'HOME': '/home/cltbld', 13:11:56 INFO - 'LANG': 'en_US.UTF-8', 13:11:56 INFO - 'LANGUAGE': 'en_US:en', 13:11:56 INFO - 'LOGNAME': 'cltbld', 13:11:56 INFO - 'MAIL': '/var/mail/cltbld', 13:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:56 INFO - 'MOZ_NO_REMOTE': '1', 13:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:56 INFO - 'NO_EM_RESTART': '1', 13:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:56 INFO - 'PWD': '/builds/slave/test', 13:11:56 INFO - 'SHELL': '/bin/bash', 13:11:56 INFO - 'SHLVL': '1', 13:11:56 INFO - 'TERM': 'linux', 13:11:56 INFO - 'TMOUT': '86400', 13:11:56 INFO - 'USER': 'cltbld', 13:11:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:56 INFO - '_': '/tools/buildbot/bin/python'} 13:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:11:58 INFO - Installing collected packages: mozsystemmonitor 13:11:58 INFO - Running setup.py install for mozsystemmonitor 13:11:58 INFO - Successfully installed mozsystemmonitor 13:11:58 INFO - Cleaning up... 13:11:59 INFO - Return code: 0 13:11:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:59 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 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:11:59 INFO - Using env: {'DISPLAY': ':0', 13:11:59 INFO - 'HOME': '/home/cltbld', 13:11:59 INFO - 'LANG': 'en_US.UTF-8', 13:11:59 INFO - 'LANGUAGE': 'en_US:en', 13:11:59 INFO - 'LOGNAME': 'cltbld', 13:11:59 INFO - 'MAIL': '/var/mail/cltbld', 13:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:59 INFO - 'MOZ_NO_REMOTE': '1', 13:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:59 INFO - 'NO_EM_RESTART': '1', 13:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:59 INFO - 'PWD': '/builds/slave/test', 13:11:59 INFO - 'SHELL': '/bin/bash', 13:11:59 INFO - 'SHLVL': '1', 13:11:59 INFO - 'TERM': 'linux', 13:11:59 INFO - 'TMOUT': '86400', 13:11:59 INFO - 'USER': 'cltbld', 13:11:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:59 INFO - '_': '/tools/buildbot/bin/python'} 13:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:59 INFO - Downloading/unpacking jsonschema==2.5.1 13:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:12:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:01 INFO - Downloading functools32-3.2.3-2.tar.gz 13:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:12:01 INFO - warning: no files found matching '*.txt' 13:12:01 INFO - no previously-included directories found matching 'build' 13:12:01 INFO - no previously-included directories found matching 'dist' 13:12:01 INFO - no previously-included directories found matching '.git*' 13:12:01 INFO - Installing collected packages: jsonschema, functools32 13:12:01 INFO - Running setup.py install for functools32 13:12:01 INFO - warning: no files found matching '*.txt' 13:12:01 INFO - no previously-included directories found matching 'build' 13:12:01 INFO - no previously-included directories found matching 'dist' 13:12:01 INFO - no previously-included directories found matching '.git*' 13:12:01 INFO - Successfully installed jsonschema functools32 13:12:01 INFO - Cleaning up... 13:12:01 INFO - Return code: 0 13:12:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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')]} 13:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:01 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 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:12:01 INFO - Using env: {'DISPLAY': ':0', 13:12:01 INFO - 'HOME': '/home/cltbld', 13:12:01 INFO - 'LANG': 'en_US.UTF-8', 13:12:01 INFO - 'LANGUAGE': 'en_US:en', 13:12:01 INFO - 'LOGNAME': 'cltbld', 13:12:01 INFO - 'MAIL': '/var/mail/cltbld', 13:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:01 INFO - 'MOZ_NO_REMOTE': '1', 13:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:01 INFO - 'NO_EM_RESTART': '1', 13:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:01 INFO - 'PWD': '/builds/slave/test', 13:12:01 INFO - 'SHELL': '/bin/bash', 13:12:01 INFO - 'SHLVL': '1', 13:12:01 INFO - 'TERM': 'linux', 13:12:01 INFO - 'TMOUT': '86400', 13:12:01 INFO - 'USER': 'cltbld', 13:12:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:01 INFO - '_': '/tools/buildbot/bin/python'} 13:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:12:01 INFO - Cleaning up... 13:12:01 INFO - Return code: 0 13:12:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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')]} 13:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:01 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 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:12:01 INFO - Using env: {'DISPLAY': ':0', 13:12:01 INFO - 'HOME': '/home/cltbld', 13:12:01 INFO - 'LANG': 'en_US.UTF-8', 13:12:01 INFO - 'LANGUAGE': 'en_US:en', 13:12:01 INFO - 'LOGNAME': 'cltbld', 13:12:01 INFO - 'MAIL': '/var/mail/cltbld', 13:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:01 INFO - 'MOZ_NO_REMOTE': '1', 13:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:01 INFO - 'NO_EM_RESTART': '1', 13:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:01 INFO - 'PWD': '/builds/slave/test', 13:12:01 INFO - 'SHELL': '/bin/bash', 13:12:01 INFO - 'SHLVL': '1', 13:12:01 INFO - 'TERM': 'linux', 13:12:01 INFO - 'TMOUT': '86400', 13:12:01 INFO - 'USER': 'cltbld', 13:12:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:01 INFO - '_': '/tools/buildbot/bin/python'} 13:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:01 INFO - Downloading/unpacking blobuploader==1.2.4 13:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:03 INFO - Downloading blobuploader-1.2.4.tar.gz 13:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:12:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:12:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:04 INFO - Downloading docopt-0.6.1.tar.gz 13:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:12:04 INFO - Installing collected packages: blobuploader, requests, docopt 13:12:04 INFO - Running setup.py install for blobuploader 13:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:12:04 INFO - Running setup.py install for requests 13:12:05 INFO - Running setup.py install for docopt 13:12:05 INFO - Successfully installed blobuploader requests docopt 13:12:05 INFO - Cleaning up... 13:12:05 INFO - Return code: 0 13:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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')]} 13:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:05 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 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:12:05 INFO - Using env: {'DISPLAY': ':0', 13:12:05 INFO - 'HOME': '/home/cltbld', 13:12:05 INFO - 'LANG': 'en_US.UTF-8', 13:12:05 INFO - 'LANGUAGE': 'en_US:en', 13:12:05 INFO - 'LOGNAME': 'cltbld', 13:12:05 INFO - 'MAIL': '/var/mail/cltbld', 13:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:05 INFO - 'MOZ_NO_REMOTE': '1', 13:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:05 INFO - 'NO_EM_RESTART': '1', 13:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:05 INFO - 'PWD': '/builds/slave/test', 13:12:05 INFO - 'SHELL': '/bin/bash', 13:12:05 INFO - 'SHLVL': '1', 13:12:05 INFO - 'TERM': 'linux', 13:12:05 INFO - 'TMOUT': '86400', 13:12:05 INFO - 'USER': 'cltbld', 13:12:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:05 INFO - '_': '/tools/buildbot/bin/python'} 13:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:05 INFO - Running setup.py (path:/tmp/pip-LJ9alu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:05 INFO - Running setup.py (path:/tmp/pip-_PskKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:05 INFO - Running setup.py (path:/tmp/pip-NDxDQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:05 INFO - Running setup.py (path:/tmp/pip-cHB3Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:05 INFO - Running setup.py (path:/tmp/pip-jC6Aug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:05 INFO - Running setup.py (path:/tmp/pip-KS2XKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:05 INFO - Running setup.py (path:/tmp/pip-XGqyFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:05 INFO - Running setup.py (path:/tmp/pip-UKZn3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:06 INFO - Running setup.py (path:/tmp/pip-qBGufg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:06 INFO - Running setup.py (path:/tmp/pip-v5NiRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:06 INFO - Running setup.py (path:/tmp/pip-10QCSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:06 INFO - Running setup.py (path:/tmp/pip-CI_Zqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:06 INFO - Running setup.py (path:/tmp/pip-DOkO0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:06 INFO - Running setup.py (path:/tmp/pip-wg2wsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:06 INFO - Running setup.py (path:/tmp/pip-g9CmQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:06 INFO - Running setup.py (path:/tmp/pip-2JXe4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:06 INFO - Running setup.py (path:/tmp/pip-7ZDe07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:12:06 INFO - Running setup.py install for manifestparser 13:12:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:12:06 INFO - Running setup.py install for mozcrash 13:12:06 INFO - Running setup.py install for mozdebug 13:12:06 INFO - Running setup.py install for mozdevice 13:12:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Running setup.py install for mozfile 13:12:07 INFO - Running setup.py install for mozhttpd 13:12:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Running setup.py install for mozinfo 13:12:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Running setup.py install for mozInstall 13:12:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Running setup.py install for mozleak 13:12:07 INFO - Running setup.py install for mozlog 13:12:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Running setup.py install for moznetwork 13:12:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Running setup.py install for mozprocess 13:12:07 INFO - Running setup.py install for mozprofile 13:12:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:12:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:12:08 INFO - Running setup.py install for mozrunner 13:12:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:12:08 INFO - Running setup.py install for mozscreenshot 13:12:08 INFO - Running setup.py install for moztest 13:12:08 INFO - Running setup.py install for mozversion 13:12:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:12:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:12:08 INFO - Cleaning up... 13:12:08 INFO - Return code: 0 13:12:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:08 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 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:12:08 INFO - Using env: {'DISPLAY': ':0', 13:12:08 INFO - 'HOME': '/home/cltbld', 13:12:08 INFO - 'LANG': 'en_US.UTF-8', 13:12:08 INFO - 'LANGUAGE': 'en_US:en', 13:12:08 INFO - 'LOGNAME': 'cltbld', 13:12:08 INFO - 'MAIL': '/var/mail/cltbld', 13:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:08 INFO - 'MOZ_NO_REMOTE': '1', 13:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:08 INFO - 'NO_EM_RESTART': '1', 13:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:08 INFO - 'PWD': '/builds/slave/test', 13:12:08 INFO - 'SHELL': '/bin/bash', 13:12:08 INFO - 'SHLVL': '1', 13:12:08 INFO - 'TERM': 'linux', 13:12:08 INFO - 'TMOUT': '86400', 13:12:08 INFO - 'USER': 'cltbld', 13:12:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:08 INFO - '_': '/tools/buildbot/bin/python'} 13:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:08 INFO - Running setup.py (path:/tmp/pip-4zuWh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:08 INFO - Running setup.py (path:/tmp/pip-DmXtQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:08 INFO - Running setup.py (path:/tmp/pip-Vwiipq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:08 INFO - Running setup.py (path:/tmp/pip-gTtCWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:08 INFO - Running setup.py (path:/tmp/pip-kIp0VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:09 INFO - Running setup.py (path:/tmp/pip-I1MXVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:09 INFO - Running setup.py (path:/tmp/pip-KkSPnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:09 INFO - Running setup.py (path:/tmp/pip-ogG2FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:09 INFO - Running setup.py (path:/tmp/pip-KZOa9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:09 INFO - Running setup.py (path:/tmp/pip-ksg39D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:09 INFO - Running setup.py (path:/tmp/pip-AR75Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:09 INFO - Running setup.py (path:/tmp/pip-75FB9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:09 INFO - Running setup.py (path:/tmp/pip-jOImDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:09 INFO - Running setup.py (path:/tmp/pip-XAqJKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:09 INFO - Running setup.py (path:/tmp/pip-vxzUzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:09 INFO - Running setup.py (path:/tmp/pip-KH7s40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:09 INFO - Running setup.py (path:/tmp/pip-ekjVVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:12:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:11 INFO - Downloading blessings-1.6.tar.gz 13:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:12:11 INFO - Installing collected packages: blessings 13:12:11 INFO - Running setup.py install for blessings 13:12:11 INFO - Successfully installed blessings 13:12:11 INFO - Cleaning up... 13:12:12 INFO - Return code: 0 13:12:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:12:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:12 INFO - Reading from file tmpfile_stdout 13:12:12 INFO - Current package versions: 13:12:12 INFO - argparse == 1.2.1 13:12:12 INFO - blessings == 1.6 13:12:12 INFO - blobuploader == 1.2.4 13:12:12 INFO - docopt == 0.6.1 13:12:12 INFO - functools32 == 3.2.3-2 13:12:12 INFO - jsonschema == 2.5.1 13:12:12 INFO - manifestparser == 1.1 13:12:12 INFO - mozInstall == 1.12 13:12:12 INFO - mozcrash == 0.17 13:12:12 INFO - mozdebug == 0.1 13:12:12 INFO - mozdevice == 0.48 13:12:12 INFO - mozfile == 1.2 13:12:12 INFO - mozhttpd == 0.7 13:12:12 INFO - mozinfo == 0.9 13:12:12 INFO - mozleak == 0.1 13:12:12 INFO - mozlog == 3.3 13:12:12 INFO - moznetwork == 0.27 13:12:12 INFO - mozprocess == 0.23 13:12:12 INFO - mozprofile == 0.28 13:12:12 INFO - mozrunner == 6.12 13:12:12 INFO - mozscreenshot == 0.1 13:12:12 INFO - mozsystemmonitor == 0.3 13:12:12 INFO - moztest == 0.7 13:12:12 INFO - mozversion == 1.4 13:12:12 INFO - psutil == 3.1.1 13:12:12 INFO - requests == 1.2.3 13:12:12 INFO - wsgiref == 0.1.2 13:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:12 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 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:12:12 INFO - Using env: {'DISPLAY': ':0', 13:12:12 INFO - 'HOME': '/home/cltbld', 13:12:12 INFO - 'LANG': 'en_US.UTF-8', 13:12:12 INFO - 'LANGUAGE': 'en_US:en', 13:12:12 INFO - 'LOGNAME': 'cltbld', 13:12:12 INFO - 'MAIL': '/var/mail/cltbld', 13:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:12 INFO - 'MOZ_NO_REMOTE': '1', 13:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:12 INFO - 'NO_EM_RESTART': '1', 13:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:12 INFO - 'PWD': '/builds/slave/test', 13:12:12 INFO - 'SHELL': '/bin/bash', 13:12:12 INFO - 'SHLVL': '1', 13:12:12 INFO - 'TERM': 'linux', 13:12:12 INFO - 'TMOUT': '86400', 13:12:12 INFO - 'USER': 'cltbld', 13:12:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:12 INFO - '_': '/tools/buildbot/bin/python'} 13:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:12:12 INFO - Cleaning up... 13:12:12 INFO - Return code: 0 13:12:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:12 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 0x296b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:12:12 INFO - Using env: {'DISPLAY': ':0', 13:12:12 INFO - 'HOME': '/home/cltbld', 13:12:12 INFO - 'LANG': 'en_US.UTF-8', 13:12:12 INFO - 'LANGUAGE': 'en_US:en', 13:12:12 INFO - 'LOGNAME': 'cltbld', 13:12:12 INFO - 'MAIL': '/var/mail/cltbld', 13:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:12 INFO - 'MOZ_NO_REMOTE': '1', 13:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:12 INFO - 'NO_EM_RESTART': '1', 13:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:12 INFO - 'PWD': '/builds/slave/test', 13:12:12 INFO - 'SHELL': '/bin/bash', 13:12:12 INFO - 'SHLVL': '1', 13:12:12 INFO - 'TERM': 'linux', 13:12:12 INFO - 'TMOUT': '86400', 13:12:12 INFO - 'USER': 'cltbld', 13:12:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:12 INFO - '_': '/tools/buildbot/bin/python'} 13:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:12:12 INFO - Cleaning up... 13:12:12 INFO - Return code: 0 13:12:12 INFO - Running post-action listener: _resource_record_post_action 13:12:12 INFO - Running post-action listener: _start_resource_monitoring 13:12:12 INFO - Starting resource monitoring. 13:12:12 INFO - [mozharness: 2016-08-01 20:12:12.756781Z] Finished create-virtualenv step (success) 13:12:12 INFO - [mozharness: 2016-08-01 20:12:12.757260Z] Running install step. 13:12:12 INFO - Running pre-action listener: _resource_record_pre_action 13:12:12 INFO - Running main action method: install 13:12:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:12 INFO - Reading from file tmpfile_stdout 13:12:13 INFO - Detecting whether we're running mozinstall >=1.0... 13:12:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:12:13 INFO - Reading from file tmpfile_stdout 13:12:13 INFO - Output received: 13:12:13 INFO - Usage: mozinstall [options] installer 13:12:13 INFO - Options: 13:12:13 INFO - -h, --help show this help message and exit 13:12:13 INFO - -d DEST, --destination=DEST 13:12:13 INFO - Directory to install application into. [default: 13:12:13 INFO - "/builds/slave/test"] 13:12:13 INFO - --app=APP Application being installed. [default: firefox] 13:12:13 INFO - mkdir: /builds/slave/test/build/application 13:12:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:12:29 INFO - Reading from file tmpfile_stdout 13:12:29 INFO - Output received: 13:12:29 INFO - /builds/slave/test/build/application/firefox/firefox 13:12:29 INFO - Running post-action listener: _resource_record_post_action 13:12:29 INFO - [mozharness: 2016-08-01 20:12:29.085615Z] Finished install step (success) 13:12:29 INFO - [mozharness: 2016-08-01 20:12:29.085952Z] Running run-tests step. 13:12:29 INFO - Running pre-action listener: _resource_record_pre_action 13:12:29 INFO - Running main action method: run_tests 13:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:12:29 INFO - Python 2.7.3 13:12:29 INFO - Return code: 0 13:12:29 INFO - grabbing minidump binary from tooltool 13:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:29 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 0x2c2a3b0>, '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 0x2c2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:12:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:12:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:12:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:12:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:12:29 INFO - Return code: 0 13:12:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:12:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:12:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:12:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:12:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:12:29 INFO - Using env: {'DISPLAY': ':0', 13:12:29 INFO - 'HOME': '/home/cltbld', 13:12:29 INFO - 'LANG': 'en_US.UTF-8', 13:12:29 INFO - 'LANGUAGE': 'en_US:en', 13:12:29 INFO - 'LOGNAME': 'cltbld', 13:12:29 INFO - 'MAIL': '/var/mail/cltbld', 13:12:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:12:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:29 INFO - 'MOZ_NO_REMOTE': '1', 13:12:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:29 INFO - 'NO_EM_RESTART': '1', 13:12:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:29 INFO - 'PWD': '/builds/slave/test', 13:12:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:12:29 INFO - 'SHELL': '/bin/bash', 13:12:29 INFO - 'SHLVL': '1', 13:12:29 INFO - 'TERM': 'linux', 13:12:29 INFO - 'TMOUT': '86400', 13:12:29 INFO - 'USER': 'cltbld', 13:12:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438', 13:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:29 INFO - '_': '/tools/buildbot/bin/python'} 13:12:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:12:29 INFO - mozversion application_buildid: 20160801100441 13:12:29 INFO - mozversion application_changeset: cace1687008bb7f514b76017f62895c23ec18c2c 13:12:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:12:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:12:29 INFO - mozversion application_name: Firefox 13:12:29 INFO - mozversion application_remotingname: firefox-dev 13:12:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:12:29 INFO - mozversion application_vendor: Mozilla 13:12:29 INFO - mozversion application_version: 50.0a2 13:12:29 INFO - mozversion platform_buildid: 20160801100441 13:12:29 INFO - mozversion platform_changeset: cace1687008bb7f514b76017f62895c23ec18c2c 13:12:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:12:29 INFO - mozversion platform_version: 50.0a2 13:12:29 INFO - using testdate: 1470082349 13:12:29 INFO - actual date: 1470082349 13:12:29 INFO - starting webserver on 'localhost:53810' 13:12:29 INFO - SUITE-START | Running 2 tests 13:12:29 INFO - TEST-START | dromaeo_css 13:12:29 INFO - operating with platform_type : linux_ 13:12:29 INFO - Initialising browser for dromaeo_css test... 13:12:29 INFO - TEST-INFO | started process 2184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8iBruq/profile http://localhost:53810/getInfo.html) 13:12:33 INFO - PROCESS | 2184 | __metrics Screen width/height:1600/1200 13:12:33 INFO - PROCESS | 2184 | colorDepth:24 13:12:33 INFO - PROCESS | 2184 | Browser inner width/height: 1024/697 13:12:33 INFO - PROCESS | 2184 | __metrics 13:12:34 INFO - PROCESS | 2184 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:12:34 INFO - PROCESS | 2184 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:12:35 INFO - TEST-INFO | 2184: exit 0 13:12:35 INFO - Browser initialized. 13:12:35 INFO - Running cycle 1/1 for dromaeo_css test... 13:12:35 INFO - TEST-INFO | started process 2272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8iBruq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:47 INFO - PROCESS | 2272 | RSS: Main: 145367040 13:12:47 INFO - PROCESS | 2272 | 13:13:37 INFO - PROCESS | 2272 | 1470082417893 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:15:46 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:53810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53810/tests/dromaeo/cssquery-ext.html) 13:15:48 INFO - PROCESS | 2272 | RSS: Main: 280252416 13:15:48 INFO - PROCESS | 2272 | 13:18:50 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:53810/tests/dromaeo/cssquery-ext.html (next: http://localhost:53810/tests/dromaeo/cssquery-jquery.html) 13:18:51 INFO - PROCESS | 2272 | RSS: Main: 232648704 13:18:51 INFO - PROCESS | 2272 | 13:21:53 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:53810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53810/tests/dromaeo/cssquery-mootools.html) 13:21:53 INFO - PROCESS | 2272 | RSS: Main: 219189248 13:21:53 INFO - PROCESS | 2272 | 13:24:55 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:53810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53810/tests/dromaeo/cssquery-prototype.html) 13:24:56 INFO - PROCESS | 2272 | RSS: Main: 189902848 13:24:56 INFO - PROCESS | 2272 | 13:27:59 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:53810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53810/tests/dromaeo/cssquery-yui.html) 13:27:59 INFO - PROCESS | 2272 | RSS: Main: 177717248 13:27:59 INFO - PROCESS | 2272 | 13:31:02 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:53810/tests/dromaeo/cssquery-yui.html (next: http://localhost:53810/tests/dromaeo/cssquery-dojo.html) 13:31:02 INFO - PROCESS | 2272 | RSS: Main: 265781248 13:31:02 INFO - PROCESS | 2272 | 13:31:02 INFO - PROCESS | 2272 | __start_tp_report 13:31:02 INFO - PROCESS | 2272 | _x_x_mozilla_page_load 13:31:02 INFO - PROCESS | 2272 | _x_x_mozilla_page_load_details 13:31:02 INFO - PROCESS | 2272 | |i|pagename|runs| 13:31:02 INFO - PROCESS | 2272 | |0;dojo.html;3198.136503144151;3225.6451790303063;3235.110344655219;3257.4950882613202;3278.7213086887614;5618.101103823389;5670.631408958415;5704.629199102061;5716;5736.368999410061;5672.971635141829;5735.541156707463;5739.253896993396;5748.511376532989;5749.856253593663;5033.874153146164;5115.769790359424;5222.973885130569;5223.921641175385;5258.737063146847;5167.534921857032;5229.633925625208;5231.529162375386;5235.397929238129;5242.135047717122;5131.923021154686;5208.817691380802;5227.424983251858;5240.082985477546;5255.395629502599;5309.017831701148;5313.362396512404;5317;5323.600729945269;5350.331208598945;5052.368453943257;5066.316047333599;5151.227315902607;5209.062368773619;5213.504717051874;5600.887982240373;5647;5664.603477756558;5682;5704.001799685038;6157.568970172089;6173.475254603364;6176.536759743038;6178;6179.443850053517;5888.057910734305;5966.164736936832;6045.576809623284;6097.237845269341;6192.071189321593;5726.713664316809;5743.597948143632;5750.683712395775;5755.453231942959;5757.712114394305;6195.473384762256;6239.906401403891;6256.718447669866;6257.812265632038;6260.46786023184;5821.854453638693;5993.730282137314;6045.486133678599;6053.273607167168;6140.539459540552;6198.907016394758;6203.31763506014;6205.875882482325;6207.565470417027;6211.844703882439;6166.753329866845;6171.56799024073;6171.722272497748;6174.104754810617;6174.9691251544355;5990.251218597676;5990.281166260077;6037.124616930609;6099.969500152471;6141.792871882685;4658.743769092733;4696.694714843524;4699.083678682692;4720.905581888343;4758.5241475852135;4186.644135248477;4199.307114326163;4200.5169405518145;4205.663546916239;4223.809928553223;5542.057850165482;5608.887822243532;5724.8282551523525;5761.962846687637;5860.120981852756;6151.231096112986;6152.384761523901;6154.9384506154365;6160.10678451622;6173.753049877954;5781;5793.420657934173;5803.680797556175;5816.767329306865;5833.88332233353;5124.487551244845;5195.142801437721;5200.5059519345605;5221.660592061504;5249.107651699221;6404.48764098871;6407.070974708734;6416.807495775134;6420.357964203636;6440.291567927524;6122.112293717475;6134.938650613437;6164.815055548341;6169.629822210682;6177.567570270217;6072.848178795565;6290.370962903673;6301.716422761078;6345.587536810092;6396.392342727433;6072.574919755575;6073.058675905242;6082.695865206633;6100.23747031621;6121.816345509642;6168.722407491584;6191.071339299141;6201.720922558406;6202.4417802398;6204.348543403058;5728.713564321684;5945.64326140433;5971.253593300838;6017.699115044143;6059.33347331802;5992.43071908168;6033.9698301508215;6054.606450580698;6055.636661800306;6067.484263837623;5933.851653708692;5981.7308221131025;5983.222181116427;5984.491318237999;6006.759729610942;5886.117082437498;5919.4376534230905;5933.317668468181;5969.552283578662;6072.72672729737;5890.587658863838;5901.173835663097;5903.734331955158;5909.23179986599;5927.881442371215 13:31:02 INFO - PROCESS | 2272 | |1;ext.html;602.6354055796243;649.8927676933306;664.0039940089864;671.2884342596844;677.1873751498204;34589.308213835706;45696.77151614241;46322.073558528806;46331.76834115825;46338.53661463384;48658.27012594814;49133.50866491334;49157.50842491574;49215;49232.2615160772;8558.657653693845;9360.251179905608;9496.810063798719;9508.429494230368;9515.238780897545;8480.151984801501;8788.780280493007;10978.341299522015;11234.662960111209;11245.60640377587;11365.374904380256;11410.144239182053;11417.143714221425;11424.657260282205;11426.028787553027;11290.830637540443;11343.602973895957;11346.092312615054;11355.318680879174;11361.659150225507;11183.664490065312;11229;11240.550377984871;11248.662540123809;11252.437378131142;46209.76895115536;46497.767511162565;46540.534594654295;46570;46595.53404465946;3838.692904567628;3948.2695701295065;4165.312723400635;4285;4524.68327217095;35985.46021809675;36020.81989590035;36075.81962090199;36177;37248;4549.45406551216;4741.952580474185;4785.282207668843;4802.375691160162;4807.567318941277;363812;364185;364420;365368.17315913516;365870;65184;65704.34295657078;65716.67141664261;65780.34219657742;65853;38929.80535097307;39370;39500.2099958005;41842;68353;18320.63358732818;18361.3573524926;18408.907955460138;18465.90767046156;18467.445976620722;12852.293123878277;13537.66155846092;14014.439422423193;14125.293735313193;14217.218053007184;20212.191512339636;21262.149514019267;21295.254666086614;21481.892590536947;21514.89242553777;7533.849323013509;7641.312281894656;7739.380849532024;7760.88358674609;7808.609569521501;1065.6376831877199;1131.9094472442184;1146.9655910322704;1182.3201659046083;1205.3129716061935;34599;34791.82604086964;35271.11822204414;35283.294334113176;35324.64675353265;1189.4469071881617;1192.7316353820322;1201.0391686650644;1254.6173417107686;1260.9558665446666;17499.737503937453;18576.628467430575;18678.719819202724;18681.813181868278;18871.811281887007;582696;592370;592559;593181;594626;64312;65119;65157.67421162864;65207;65266;1338.2104558310448;1406.4022790314075;1466.3401469338628;1470.125275461099;1491.7911492391074;33577.16057098592;35260.647393526764;35473.645263547034;35842.462363064056;35942.640573593926;54037.027963460816;54668;54672.17991730048;54694.17958730543;54699.17951230815;420390;423821;425643;425934;427049;27914.860425698553;28550;28778;28832.279193020342;32893;52904.20643690271;52929.47070529399;53162;53895.73052134714;54023;44548.109037818416;45183.32225016561;45298.77350613226;45544;46816.7659161702;44616.217128615215;45898.08203835838;46621.53378466172;46822.53177468182;47293.52706473029;44074.77962610166;44081.55918440903;44263.336049958634;45019;45030.09939801251;38682.80658596689;40114;40350.798246008584;40875.36021261796;40918.1816363677;29062.564061539517;29227.85386073056;29564.408711825214;29667.554986674786;29902.102936911928 13:31:02 INFO - PROCESS | 2272 | |2;jquery.html;395.5629029921938;408.2202992284735;417.9226843034038;419.46937124537465;426.98719038428857;15760;19946;20269.695954560673;20640.277590284342;21992.670109948365;20911.372658820223;20969.580608387823;21023.789762102373;21226.257081002168;21327.466813329636;5528.115501519757;5908.054711246202;5954.70226488676;5964.463198312151;5966.403359664042;4373.387725718402;4443.755593442359;5892.764289428418;5967.671778052206;5972.193753843219;6476.384743449365;6573.948168293074;6574.3754343337305;6575.408213260829;6578.111954886077;6379.138816259792;6541.542092053558;6570.63861487618;6571.244306904719;6581.967090164567;5864.354920958691;5865.35481097079;5867.11993201019;5868.2664666916635;5869.79455719052;23589.882050589807;23698.170564030348;23757;23805.166819161248;23853.7614623855;2657.5349313869997;2796.986015069932;2840.8863645454157;2855.214815925637;2875.353045564752;10559.577616895393;11075.224734268604;11130.38782866942;15807.920960395239;16013.519594412186;2068.5449201175866;2099.391176558796;2159.2982280758815;2182.159868450658;2182.181681869299;69617.65191174012;73605.63197184034;75392;75707.24292757057;87261.56369218176;11468.827967580493;11471.139664525193;11664.533418663159;11838.526458941546;11865.940670296593;15949.521514354588;15958.361665533248;15984.120873352078;16050.518484445485;16071.35714571404;8485.448445851;8735.432196907308;8747.475151490931;8751.693690720795;8933.19601235892;8498.320134389234;8559.272461840814;8568.657253709782;8684.696035638723;8735.213830755136;4807.927881081787;4816.543562783006;4860.222364421676;4988.575971042429;5035.546800787946;1977.4759688682511;1981.8315443187203;2021.545152340741;2055.424481145282;2058.588282343507;488.272474013717;489.1073790332657;742.3912293328385;983.188869182927;1009.2682804966487;12165.391730413445;12708;12867.356632168354;12872.678183045311;12915.160514566523;486.99513004870204;496.1614870868293;504.50054446098096;524.3314773663609;531.6544246239974;6788.151481064867;6801.081853949752;6906.965465172642;6940.375366217065;6985.476089293324;546404;548617;549890;553041;555655;68532.3146768536;98902.5054874721;101879.490602548;102534.48732756288;104535;499.34835040272065;509.4243504839508;510.2321006884689;510.7931287828361;511.1591432094184;11889.940550297193;17804.55488612795;18812.52968675794;18815.153318100445;20011;45866.541334586225;46024.30963535616;46139.3079103807;46940.53059469361;48181.03637927292;53231.46768532265;60350.69824650849;62213;62522.37477625166;63035.68482157743;8743.737687869374;9164.770880728036;9206;9343.81312373735;9372.1565059145;12286.815697764361;13536.323183840965;13612.65968350799;14043.789343159657;14112.36494357777;10577;11626.244294120856;11960.521579136737;12193.756124877631;12529.18560293578;5566.118075772796;5726.5418766499415;8534.274586660204;10528.052475277262;10593.576256949636;11571.305721656727;11573.074154067823;11716;11838.940805295919;11987.700307492383;7714;9078.500682462529;9136.63453461854;9185.265178785814;9557.139857412867;8840.469571825453;12029.819552706891;12269.263844169378;12331.568395106127;12416.875831241934 13:31:02 INFO - PROCESS | 2272 | |3;mootools.html;1562.7499600063984;1613.2982152763548;1818.8363047325738;1842.649896519662;1934.2649793078629;9198.54007299635;9918.752031199223;9923.20614350852;9926.652567160141;9936.254780891426;8241.299489543397;9119.179273865351;9340.299477539194;9379.812403751921;9664.661736839213;2398.100712232917;2450.105711415338;2451.595486744685;2452.766987136219;2453.766892145243;2396.928092157238;2420.419099416145;2449.1183174057323;2456.0421435640023;2459.803215742745;2212.1372664660794;2377.7384487706427;2424.7090349158125;2447.290285817111;2466.0998735461517;2436.0377650827913;2449.4856080223176;2451.1298489036494;2453.7914277286454;2455.26342097371;2461.876906154685;2479.454520005614;2480.454300053985;2484.8260621756485;2486.3784053986506;9711.320207585472;9775.560099795526;9818.607255709763;9904.653337133166;9918.90081099187;5550.111982082847;5688.914666280009;5698.173764804122;5700.515456186229;5702.258706368187;3507.8947631571095;3593.4609808528667;3645.908852278714;3664.486971823947;3667.0832291927018;1159.232170939316;1172.4020749417773;1198.6044605280324;1219.6402061391912;1229.7356068445326;13499.730005399935;13640.045196836225;13670.658233544142;13680.65798355039;13683.931580342134;4642.134826075686;4716.434027916672;4788.808447662054;4886.853394398174;4916.139675556835;10727.892721072845;10728.624498142528;10736.409497477714;10743.409112498732;10745.247832651796;5609.523190528769;5654.6324488908085;5662.065759149694;5668.546516278688;5670.5747068969995;5224.686518808883;5257.316548848702;5261.158214685632;5298.178782288752;5336.573074154058;3921.8235179416993;4012.6388625023305;4020.19596080785;4062.187562487455;4134.338505839051;1057.3814318623538;1195.3485350484007;1195.647284051207;1195.7907366210877;1203.48851738011;992.7518120469882;1093.8413929980109;1099.3294090604725;1110.3005106782675;1115.2806439846415;6401.967990160112;6685.799426017227;6694.799156025327;6791.728330866808;6805.421539169127;514.2594663684283;529.7907326606046;545.4490964126261;547.9369872464638;698.1656919980575;4514.571115743999;4630.21286381316;4658.953410465852;4721.622270218443;4780.545848144421;11999.760004799855;12111.515539378503;12305.56930507428;12438.626841194779;12539.87460125387;12104.15270931044;12312.507499699912;12329.198602090835;12334.629961101182;12380.504779808707;9110.27117830572;9144.588493517807;9208.723738287863;9236.26109911192;9241.399309044891;6520.478361730955;6562.704678289393;6590.077389165616;6677.3656502632175;6686.364795344434;11010.284331518425;11312.660620181408;11409.60066397672;11460.484278207334;11538.423078845855;11288.604898828502;11394.487248074023;11495.712607184887;11553.24903881245;11615.431916691476;7781.144074151952;7844.097928738268;8372.497650141011;8603.35474839402;8621.094785047731;9615.2307815376;9689.27330450205;9693.321467497208;9697.854532181882;9699.224062074876;8465.703700370705;8518.403711740119;8663.826723465621;8682.262007729414;8898.688545900863;8406.789830254293;8498.065212826708;8500.74497765068;8589.355798315026;8740.912590874264;7955.2840244378285;7962.92037079645;7992;8016.1182269949095;8019;5774.133879918046;5877.94122058774;5883.61756485827;5888.116782482662;6066.059760737093;5884.7940322088525;5897.7935772247765;5914.704264786657;5926;6244.812655620339 13:31:02 INFO - PROCESS | 2272 | |4;prototype.html;341.78296781543713;346.3626926455322;351.9841607127679;362.3188405797101;362.6138162856559;5452.182172674101;5482.259894914186;5590.217369568259;5655.5475561955045;5675.091985282355;5407.756650950707;5472.151816468454;5497.285352904127;5551.361593416758;5554.1946417769395;4384.934225986613;4394.209042372372;4403.163398954189;4426.778661066934;4440;4238.258304796664;4353.912921741563;4388.802503887317;4408.16244913467;4487.708298960573;4382.605565499104;4391.736495810262;4396.1427521633295;4421.491528474218;4442.666799989997;4364.781760911942;4395.956040439587;4397.274449715809;4407.845725399612;4425.291953287458;3824.2542704172697;3885.3977633466857;3923.784191869446;3932.370820668708;3963.2667956428154;5383.488568585978;5384.91922621161;5394.599403265548;5410.91883621746;5437.483439073281;5058.392992840846;5062.265971434158;5062.367204099488;5093.363329583802;5102.770375333119;5555;5774.393688662672;5787.33445653751;5802.419758024206;5823.38854420284;4327.723321620129;4338.240807858644;4355.281378572563;4356.150550642626;4362.47650281965;5974.880502389971;6039.54703397247;6117.143599896018;6150.2927163376335;6157.9384206158265;4395.846145384896;4406.25093734066;4420.58004489573;4433.933490997638;4462.947044359631;4465.4864690561;4477.888052798641;4510.932336014962;4519.977400112978;4533.954660453419;4857.125717370836;5051.26756620288;5056.418511871182;5066.847994560169;5081.618878584121;5503.862403439866;5795.159701843209;5805.709714514342;5821.388754180834;5829.358770535237;1507.7636338202788;1546.8994515356467;1552.5808031831343;1566.6396728752222;1571.5599632103028;977.8875429325576;1004.4073996342047;1016.2530540053056;1028.547439126782;1029.9897001029894;5013.373328333958;5018.666320161143;5033.949660503421;5038.370203724535;5067.417247016567;5268.815591454358;5269.604779641542;5289.312389389354;5295.761690723926;5319.601029922771;4626.362973105298;4957.851264462072;4960.627952903475;4976.253561965662;5038.496150384932;2813.338865366637;2821.9858900705367;2824.5198316286283;2825.954396873129;2829.221963959886;5460.180972854024;5531.474509921551;5573.637713548687;5575.219469274305;5596.4403559644525;5101.897962040738;5336.67979921206;5373.468561459965;5374.758135883894;5393.217983392465;5404.594655400861;5445.264889239902;5488.463230295523;5491.725413729378;5498.780048798083;5120.695819110603;5238.895222095613;5302.70835104073;5309.415964244007;5340.652857564246;5061.949380506295;5120.590352771695;5154.61340399464;5185.22221666753;5220.833354157982;5382.703951282717;5462.371827239918;5467.589930755289;5487.835364939058;5545.64310168185;3915;4027.637512623878;4069.5726948669962;4076.7553946763287;4115.300398932129;5241.353116676054;5257.737113144404;5309.65487243328;5802.767889284381;5858.9121163181735;5839.89042082003;5866.442687944638;5896.292444906639;5904.291485021825;5913.497352725067;5830.2129212555765;5844.181814545882;5896.113243762126;5897.882042359043;5911.231539899785;5635.295588051494;5762.308522977102;5773.624714393551;5807.274090738658;5817.970910145422;5837.357890632112;5837.883242335214;5892.852678682896;5898.439648233411;5907.409259074058;5620.718964051863;5733.455321744427;5746.569007324551;5792.4497172768515;5802.50678692299 13:31:02 INFO - PROCESS | 2272 | |5;yui.html;822.7202751064636;860.2902605350583;886.7605746448459;900.2123142250531;915.53765348499;17102.05938673374;17837.464876053724;18105.547361315974;18184.181711822966;18215.72676409855;16238.431654892081;16439;16471.34114635416;16486.25811838467;16488;730.8538292341526;860.3590325207714;873.2577309287087;883.0683628771643;883.8718385834051;893.5710858787786;896.1038961038961;896.9775755606097;897.0536084430922;897.3897749530316;922.1608336413865;922.6401703335705;923.4274749655223;924.2836801478874;924.4684306523742;772.2624893226982;928.4893308680232;930.6975233049286;935.864299676543;941.8869735631733;661.3221448015775;663.4062514049947;664.1432552007903;664.8537321789198;668.7325069972002;16268.83731162685;16297.103659298733;16297.83702162975;16348.182590870409;16350;15611.765823512656;15955.256384874328;16050.277737501841;16981.830181698147;17465;14741.189234592093;14785.630359240997;14841.851581484263;14858.108513489226;14957.102573845605;4804.4234691836855;4826.758662066918;4837.226043833005;4841.2496063110275;4881.438634557036;83030.58484707538;83235;83323.16676833214;83354.74967875547;83708;12318.445669944875;13209.471621135048;13356.398962046536;13426;14001.5099471518;23552;24136.396590085387;24963.375915601893;25306.493870122493;25398.365040874127;9440.291978101532;9697.806043879084;9736.707898762907;9839.311248212556;9919.950400247953;5029.421616514074;5178.715170665574;5188.040212560688;5192.532672059458;5325.8934821303355;3914.5693973662874;4015.19696060789;4049.0484736086996;4108.424820525129;4115.773632450184;697.6058526932369;698.4063545985871;704.9471289653296;712.3659942651045;718.8849784034529;595.9910601340983;721.6463932672953;783.7296132834163;799.5122974985254;829.5769157729601;10238.283320167666;10716.249862509705;10987.725306867393;11274.887251127548;11281.548738050551;688.4389222783416;712.3588770106842;745.4632664481564;797.9840403191904;810.8986376702912;4912.852614421573;5139.100657384943;5152.3044389007;5293.073712100367;5307.65500242483;79292.6035369831;112484;113239.43380283046;114148.42925785483;116572.41713791377;101715.49142254241;102812;104706;104719.4764026175;105188;83365;88682;88747;89539.55230223807;90253;10771.946140269249;11286.829389171107;11310.94344528272;11353.489092991;11450.370229637118;53678.463215367345;54518.45481545134;54564.18153727618;55719.16421253765;57907;73414.63292683502;78185.2181478178;82598.58700706458;84361;84443.57778211315;14145.080569762933;14413.13521188732;14575.562733118024;14751.262436878327;14778.852211477748;16190.514284571482;16332.101734404721;16526.917365413097;17666.911665441592;17703.29186832564;14881.404743810559;15013.549593512213;15090.698186035997;15174.317155727798;16437;13199.274039927896;13803.378847951666;14071.718565628425;14757.114573125647;14818.77771833445;13123.934380328037;13306.933465332611;13307.86692133105;13837.100588461717;13880.167189968633;11707.531698731955;11804.40977951082;11980.46087926028;11999.460024298753;12617.306048167438;12344.4444999977;12411.255324680547;12762.17045892014;12829.61511154667;13002.869971300166 13:31:02 INFO - PROCESS | 2272 | __end_tp_report 13:31:02 INFO - PROCESS | 2272 | __start_cc_report 13:31:02 INFO - PROCESS | 2272 | _x_x_mozilla_cycle_collect,1119 13:31:02 INFO - PROCESS | 2272 | __end_cc_report 13:31:02 INFO - PROCESS | 2272 | __startTimestamp1470083462510__endTimestamp 13:31:02 INFO - PROCESS | 2272 | 13:31:02 INFO - PROCESS | 2272 | ------- Summary: start ------- 13:31:02 INFO - PROCESS | 2272 | Number of tests: 6 13:31:02 INFO - PROCESS | 2272 | 13:31:02 INFO - PROCESS | 2272 | [#0] dojo.html Cycles:165 Average:5689.64 Median:5909.23 stddev:658.03 (11.1%) stddev-sans-first:630.36 13:31:02 INFO - PROCESS | 2272 | Values: 3198.1 3225.6 3235.1 3257.5 3278.7 5618.1 5670.6 5704.6 5716.0 5736.4 5673.0 5735.5 5739.3 5748.5 5749.9 5033.9 5115.8 5223.0 5223.9 5258.7 5167.5 5229.6 5231.5 5235.4 5242.1 5131.9 5208.8 5227.4 5240.1 5255.4 5309.0 5313.4 5317.0 5323.6 5350.3 5052.4 5066.3 5151.2 5209.1 5213.5 5600.9 5647.0 5664.6 5682.0 5704.0 6157.6 6173.5 6176.5 6178.0 6179.4 5888.1 5966.2 6045.6 6097.2 6192.1 5726.7 5743.6 5750.7 5755.5 5757.7 6195.5 6239.9 6256.7 6257.8 6260.5 5821.9 5993.7 6045.5 6053.3 6140.5 6198.9 6203.3 6205.9 6207.6 6211.8 6166.8 6171.6 6171.7 6174.1 6175.0 5990.3 5990.3 6037.1 6100.0 6141.8 4658.7 4696.7 4699.1 4720.9 4758.5 4186.6 4199.3 4200.5 4205.7 4223.8 5542.1 5608.9 5724.8 5762.0 5860.1 6151.2 6152.4 6154.9 6160.1 6173.8 5781.0 5793.4 5803.7 5816.8 5833.9 5124.5 5195.1 5200.5 5221.7 5249.1 6404.5 6407.1 6416.8 6420.4 6440.3 6122.1 6134.9 6164.8 6169.6 6177.6 6072.8 6290.4 6301.7 6345.6 6396.4 6072.6 6073.1 6082.7 6100.2 6121.8 6168.7 6191.1 6201.7 6202.4 6204.3 5728.7 5945.6 5971.3 6017.7 6059.3 5992.4 6034.0 6054.6 6055.6 6067.5 5933.9 5981.7 5983.2 5984.5 6006.8 5886.1 5919.4 5933.3 5969.6 6072.7 5890.6 5901.2 5903.7 5909.2 5927.9 13:31:02 INFO - PROCESS | 2272 | 13:31:02 INFO - PROCESS | 2272 | [#1] ext.html Cycles:180 Average:63669.01 Median:40232.40 stddev:124529.44 (309.5%) stddev-sans-first:124788.76 13:31:02 INFO - PROCESS | 2272 | Values: 602.6 649.9 664.0 671.3 677.2 34589.3 45696.8 46322.1 46331.8 46338.5 48658.3 49133.5 49157.5 49215.0 49232.3 8558.7 9360.3 9496.8 9508.4 9515.2 8480.2 8788.8 10978.3 11234.7 11245.6 11365.4 11410.1 11417.1 11424.7 11426.0 11290.8 11343.6 11346.1 11355.3 11361.7 11183.7 11229.0 11240.6 11248.7 11252.4 46209.8 46497.8 46540.5 46570.0 46595.5 3838.7 3948.3 4165.3 4285.0 4524.7 35985.5 36020.8 36075.8 36177.0 37248.0 4549.5 4742.0 4785.3 4802.4 4807.6 363812.0 364185.0 364420.0 365368.2 365870.0 65184.0 65704.3 65716.7 65780.3 65853.0 38929.8 39370.0 39500.2 41842.0 68353.0 18320.6 18361.4 18408.9 18465.9 18467.4 12852.3 13537.7 14014.4 14125.3 14217.2 20212.2 21262.1 21295.3 21481.9 21514.9 7533.8 7641.3 7739.4 7760.9 7808.6 1065.6 1131.9 1147.0 1182.3 1205.3 34599.0 34791.8 35271.1 35283.3 35324.6 1189.4 1192.7 1201.0 1254.6 1261.0 17499.7 18576.6 18678.7 18681.8 18871.8 582696.0 592370.0 592559.0 593181.0 594626.0 64312.0 65119.0 65157.7 65207.0 65266.0 1338.2 1406.4 1466.3 1470.1 1491.8 33577.2 35260.6 35473.6 35842.5 35942.6 54037.0 54668.0 54672.2 54694.2 54699.2 420390.0 423821.0 425643.0 425934.0 427049.0 27914.9 28550.0 28778.0 28832.3 32893.0 52904.2 52929.5 53162.0 53895.7 54023.0 44548.1 45183.3 45298.8 45544.0 46816.8 44616.2 45898.1 46621.5 46822.5 47293.5 44074.8 44081.6 44263.3 45019.0 45030.1 38682.8 40114.0 40350.8 40875.4 40918.2 29062.6 29227.9 29564.4 29667.6 29902.1 13:31:02 INFO - PROCESS | 2272 | 13:31:02 INFO - PROCESS | 2272 | [#2] jquery.html Cycles:180 Average:30773.13 Median:25874.23 stddev:90598.55 (350.1%) stddev-sans-first:90823.99 13:31:02 INFO - PROCESS | 2272 | Values: 395.6 408.2 417.9 419.5 427.0 15760.0 19946.0 20269.7 20640.3 21992.7 20911.4 20969.6 21023.8 21226.3 21327.5 5528.1 5908.1 5954.7 5964.5 5966.4 4373.4 4443.8 5892.8 5967.7 5972.2 6476.4 6573.9 6574.4 6575.4 6578.1 6379.1 6541.5 6570.6 6571.2 6582.0 5864.4 5865.4 5867.1 5868.3 5869.8 23589.9 23698.2 23757.0 23805.2 23853.8 2657.5 2797.0 2840.9 2855.2 2875.4 10559.6 11075.2 11130.4 15807.9 16013.5 2068.5 2099.4 2159.3 2182.2 2182.2 69617.7 73605.6 75392.0 75707.2 87261.6 11468.8 11471.1 11664.5 11838.5 11865.9 15949.5 15958.4 15984.1 16050.5 16071.4 8485.4 8735.4 8747.5 8751.7 8933.2 8498.3 8559.3 8568.7 8684.7 8735.2 4807.9 4816.5 4860.2 4988.6 5035.5 1977.5 1981.8 2021.5 2055.4 2058.6 488.3 489.1 742.4 983.2 1009.3 12165.4 12708.0 12867.4 12872.7 12915.2 487.0 496.2 504.5 524.3 531.7 6788.2 6801.1 6907.0 6940.4 6985.5 546404.0 548617.0 549890.0 553041.0 555655.0 68532.3 98902.5 101879.5 102534.5 104535.0 499.3 509.4 510.2 510.8 511.2 11889.9 17804.6 18812.5 18815.2 20011.0 45866.5 46024.3 46139.3 46940.5 48181.0 53231.5 60350.7 62213.0 62522.4 63035.7 8743.7 9164.8 9206.0 9343.8 9372.2 12286.8 13536.3 13612.7 14043.8 14112.4 10577.0 11626.2 11960.5 12193.8 12529.2 5566.1 5726.5 8534.3 10528.1 10593.6 11571.3 11573.1 11716.0 11838.9 11987.7 7714.0 9078.5 9136.6 9185.3 9557.1 8840.5 12029.8 12269.3 12331.6 12416.9 13:31:02 INFO - PROCESS | 2272 | 13:31:02 INFO - PROCESS | 2272 | [#3] mootools.html Cycles:180 Average:6378.24 Median:4784.68 stddev:3717.82 (77.7%) stddev-sans-first:3710.64 13:31:02 INFO - PROCESS | 2272 | Values: 1562.7 1613.3 1818.8 1842.6 1934.3 9198.5 9918.8 9923.2 9926.7 9936.3 8241.3 9119.2 9340.3 9379.8 9664.7 2398.1 2450.1 2451.6 2452.8 2453.8 2396.9 2420.4 2449.1 2456.0 2459.8 2212.1 2377.7 2424.7 2447.3 2466.1 2436.0 2449.5 2451.1 2453.8 2455.3 2461.9 2479.5 2480.5 2484.8 2486.4 9711.3 9775.6 9818.6 9904.7 9918.9 5550.1 5688.9 5698.2 5700.5 5702.3 3507.9 3593.5 3645.9 3664.5 3667.1 1159.2 1172.4 1198.6 1219.6 1229.7 13499.7 13640.0 13670.7 13680.7 13683.9 4642.1 4716.4 4788.8 4886.9 4916.1 10727.9 10728.6 10736.4 10743.4 10745.2 5609.5 5654.6 5662.1 5668.5 5670.6 5224.7 5257.3 5261.2 5298.2 5336.6 3921.8 4012.6 4020.2 4062.2 4134.3 1057.4 1195.3 1195.6 1195.8 1203.5 992.8 1093.8 1099.3 1110.3 1115.3 6402.0 6685.8 6694.8 6791.7 6805.4 514.3 529.8 545.4 547.9 698.2 4514.6 4630.2 4659.0 4721.6 4780.5 11999.8 12111.5 12305.6 12438.6 12539.9 12104.2 12312.5 12329.2 12334.6 12380.5 9110.3 9144.6 9208.7 9236.3 9241.4 6520.5 6562.7 6590.1 6677.4 6686.4 11010.3 11312.7 11409.6 11460.5 11538.4 11288.6 11394.5 11495.7 11553.2 11615.4 7781.1 7844.1 8372.5 8603.4 8621.1 9615.2 9689.3 9693.3 9697.9 9699.2 8465.7 8518.4 8663.8 8682.3 8898.7 8406.8 8498.1 8500.7 8589.4 8740.9 7955.3 7962.9 7992.0 8016.1 8019.0 5774.1 5877.9 5883.6 5888.1 6066.1 5884.8 5897.8 5914.7 5926.0 6244.8 13:31:02 INFO - PROCESS | 2272 | 13:31:02 INFO - PROCESS | 2272 | [#4] prototype.html Cycles:180 Average:4743.74 Median:5229.86 stddev:1340.34 (25.6%) stddev-sans-first:1302.74 13:31:02 INFO - PROCESS | 2272 | Values: 341.8 346.4 352.0 362.3 362.6 5452.2 5482.3 5590.2 5655.5 5675.1 5407.8 5472.2 5497.3 5551.4 5554.2 4384.9 4394.2 4403.2 4426.8 4440.0 4238.3 4353.9 4388.8 4408.2 4487.7 4382.6 4391.7 4396.1 4421.5 4442.7 4364.8 4396.0 4397.3 4407.8 4425.3 3824.3 3885.4 3923.8 3932.4 3963.3 5383.5 5384.9 5394.6 5410.9 5437.5 5058.4 5062.3 5062.4 5093.4 5102.8 5555.0 5774.4 5787.3 5802.4 5823.4 4327.7 4338.2 4355.3 4356.2 4362.5 5974.9 6039.5 6117.1 6150.3 6157.9 4395.8 4406.3 4420.6 4433.9 4462.9 4465.5 4477.9 4510.9 4520.0 4534.0 4857.1 5051.3 5056.4 5066.8 5081.6 5503.9 5795.2 5805.7 5821.4 5829.4 1507.8 1546.9 1552.6 1566.6 1571.6 977.9 1004.4 1016.3 1028.5 1030.0 5013.4 5018.7 5033.9 5038.4 5067.4 5268.8 5269.6 5289.3 5295.8 5319.6 4626.4 4957.9 4960.6 4976.3 5038.5 2813.3 2822.0 2824.5 2826.0 2829.2 5460.2 5531.5 5573.6 5575.2 5596.4 5101.9 5336.7 5373.5 5374.8 5393.2 5404.6 5445.3 5488.5 5491.7 5498.8 5120.7 5238.9 5302.7 5309.4 5340.7 5061.9 5120.6 5154.6 5185.2 5220.8 5382.7 5462.4 5467.6 5487.8 5545.6 3915.0 4027.6 4069.6 4076.8 4115.3 5241.4 5257.7 5309.7 5802.8 5858.9 5839.9 5866.4 5896.3 5904.3 5913.5 5830.2 5844.2 5896.1 5897.9 5911.2 5635.3 5762.3 5773.6 5807.3 5818.0 5837.4 5837.9 5892.9 5898.4 5907.4 5620.7 5733.5 5746.6 5792.4 5802.5 13:31:02 INFO - PROCESS | 2272 | 13:31:02 INFO - PROCESS | 2272 | [#5] yui.html Cycles:180 Average:22098.80 Median:4032.12 stddev:30431.85 (754.7%) stddev-sans-first:30475.28 13:31:02 INFO - PROCESS | 2272 | Values: 822.7 860.3 886.8 900.2 915.5 17102.1 17837.5 18105.5 18184.2 18215.7 16238.4 16439.0 16471.3 16486.3 16488.0 730.9 860.4 873.3 883.1 883.9 893.6 896.1 897.0 897.1 897.4 922.2 922.6 923.4 924.3 924.5 772.3 928.5 930.7 935.9 941.9 661.3 663.4 664.1 664.9 668.7 16268.8 16297.1 16297.8 16348.2 16350.0 15611.8 15955.3 16050.3 16981.8 17465.0 14741.2 14785.6 14841.9 14858.1 14957.1 4804.4 4826.8 4837.2 4841.2 4881.4 83030.6 83235.0 83323.2 83354.7 83708.0 12318.4 13209.5 13356.4 13426.0 14001.5 23552.0 24136.4 24963.4 25306.5 25398.4 9440.3 9697.8 9736.7 9839.3 9920.0 5029.4 5178.7 5188.0 5192.5 5325.9 3914.6 4015.2 4049.0 4108.4 4115.8 697.6 698.4 704.9 712.4 718.9 596.0 721.6 783.7 799.5 829.6 10238.3 10716.2 10987.7 11274.9 11281.5 688.4 712.4 745.5 798.0 810.9 4912.9 5139.1 5152.3 5293.1 5307.7 79292.6 112484.0 113239.4 114148.4 116572.4 101715.5 102812.0 104706.0 104719.5 105188.0 83365.0 88682.0 88747.0 89539.6 90253.0 10771.9 11286.8 11310.9 11353.5 11450.4 53678.5 54518.5 54564.2 55719.2 57907.0 73414.6 78185.2 82598.6 84361.0 84443.6 14145.1 14413.1 14575.6 14751.3 14778.9 16190.5 16332.1 16526.9 17666.9 17703.3 14881.4 15013.5 15090.7 15174.3 16437.0 13199.3 13803.4 14071.7 14757.1 14818.8 13123.9 13306.9 13307.9 13837.1 13880.2 11707.5 11804.4 11980.5 11999.5 12617.3 12344.4 12411.3 12762.2 12829.6 13002.9 13:31:02 INFO - PROCESS | 2272 | -------- Summary: end -------- 13:31:02 INFO - PROCESS | 2272 | 13:31:03 INFO - TEST-INFO | 2272: exit 0 13:31:03 INFO - TEST-OK | dromaeo_css | took 1113936ms 13:31:03 INFO - TEST-START | kraken 13:31:03 INFO - operating with platform_type : linux_ 13:31:03 INFO - Initialising browser for kraken test... 13:31:03 INFO - TEST-INFO | started process 2578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0de6B/profile http://localhost:53810/getInfo.html) 13:31:07 INFO - PROCESS | 2578 | __metrics Screen width/height:1600/1200 13:31:07 INFO - PROCESS | 2578 | colorDepth:24 13:31:07 INFO - PROCESS | 2578 | Browser inner width/height: 1024/697 13:31:07 INFO - PROCESS | 2578 | __metrics 13:31:08 INFO - PROCESS | 2578 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:31:08 INFO - PROCESS | 2578 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:31:09 INFO - TEST-INFO | 2578: exit 0 13:31:09 INFO - Browser initialized. 13:31:09 INFO - Running cycle 1/1 for kraken test... 13:31:09 INFO - TEST-INFO | started process 2666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0de6B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:20 INFO - PROCESS | 2666 | RSS: Main: 145821696 13:31:20 INFO - PROCESS | 2666 | 13:31:23 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53810/tests/kraken/driver.html?testName=audio-beat-detection) 13:31:24 INFO - PROCESS | 2666 | RSS: Main: 192102400 13:31:24 INFO - PROCESS | 2666 | 13:31:26 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53810/tests/kraken/driver.html?testName=audio-dft) 13:31:27 INFO - PROCESS | 2666 | RSS: Main: 180899840 13:31:27 INFO - PROCESS | 2666 | 13:31:29 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53810/tests/kraken/driver.html?testName=audio-fft) 13:31:30 INFO - PROCESS | 2666 | RSS: Main: 269701120 13:31:30 INFO - PROCESS | 2666 | 13:31:32 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53810/tests/kraken/driver.html?testName=audio-oscillator) 13:31:33 INFO - PROCESS | 2666 | RSS: Main: 175517696 13:31:33 INFO - PROCESS | 2666 | 13:31:35 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:31:35 INFO - PROCESS | 2666 | RSS: Main: 176693248 13:31:35 INFO - PROCESS | 2666 | 13:31:38 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53810/tests/kraken/driver.html?testName=imaging-darkroom) 13:31:39 INFO - PROCESS | 2666 | RSS: Main: 213114880 13:31:39 INFO - PROCESS | 2666 | 13:31:42 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53810/tests/kraken/driver.html?testName=imaging-desaturate) 13:31:43 INFO - PROCESS | 2666 | RSS: Main: 211701760 13:31:43 INFO - PROCESS | 2666 | 13:31:46 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53810/tests/kraken/driver.html?testName=json-parse-financial) 13:31:46 INFO - PROCESS | 2666 | RSS: Main: 211582976 13:31:46 INFO - PROCESS | 2666 | 13:31:48 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:31:49 INFO - PROCESS | 2666 | RSS: Main: 175898624 13:31:49 INFO - PROCESS | 2666 | 13:31:50 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53810/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:31:51 INFO - PROCESS | 2666 | RSS: Main: 180613120 13:31:51 INFO - PROCESS | 2666 | 13:31:53 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:31:53 INFO - PROCESS | 2666 | RSS: Main: 186388480 13:31:53 INFO - PROCESS | 2666 | 13:31:56 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:31:57 INFO - PROCESS | 2666 | RSS: Main: 181313536 13:31:57 INFO - PROCESS | 2666 | 13:31:59 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:32:00 INFO - PROCESS | 2666 | RSS: Main: 183988224 13:32:00 INFO - PROCESS | 2666 | 13:32:01 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:53810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53810/tests/kraken/driver.html?testName=ai-astar) 13:32:02 INFO - PROCESS | 2666 | RSS: Main: 236138496 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | __start_tp_report 13:32:02 INFO - PROCESS | 2666 | _x_x_mozilla_page_load 13:32:02 INFO - PROCESS | 2666 | _x_x_mozilla_page_load_details 13:32:02 INFO - PROCESS | 2666 | |i|pagename|runs| 13:32:02 INFO - PROCESS | 2666 | |0;ai-astar;101;111;112;111;110;112;110;109;108;109 13:32:02 INFO - PROCESS | 2666 | |1;audio-beat-detection;138;115;115;171;121;120;140;115;155;114 13:32:02 INFO - PROCESS | 2666 | |2;audio-dft;159;161;159;161;159;159;160;160;161;159 13:32:02 INFO - PROCESS | 2666 | |3;audio-fft;76;76;77;131;76;75;73;74;109;76 13:32:02 INFO - PROCESS | 2666 | |4;audio-oscillator;84;83;124;83;83;82;111;83;82;132 13:32:02 INFO - PROCESS | 2666 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;116;118;117 13:32:02 INFO - PROCESS | 2666 | |6;imaging-darkroom;145;145;145;146;148;145;146;146;146;146 13:32:02 INFO - PROCESS | 2666 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;94;94 13:32:02 INFO - PROCESS | 2666 | |8;json-parse-financial;50;51;53;51;50;51;49;49;50;52 13:32:02 INFO - PROCESS | 2666 | |9;json-stringify-tinderbox;62;63;64;64;63;62;63;62;63;62 13:32:02 INFO - PROCESS | 2666 | |10;stanford-crypto-aes;72;72;73;72;82;75;72;72;81;76 13:32:02 INFO - PROCESS | 2666 | |11;stanford-crypto-ccm;122;130;124;115;123;116;121;116;159;132 13:32:02 INFO - PROCESS | 2666 | |12;stanford-crypto-pbkdf2;154;153;152;152;150;152;153;155;149;154 13:32:02 INFO - PROCESS | 2666 | |13;stanford-crypto-sha256-iterative;67;61;61;60;61;62;61;59;59;61 13:32:02 INFO - PROCESS | 2666 | __end_tp_report 13:32:02 INFO - PROCESS | 2666 | __start_cc_report 13:32:02 INFO - PROCESS | 2666 | _x_x_mozilla_cycle_collect,1610 13:32:02 INFO - PROCESS | 2666 | __end_cc_report 13:32:02 INFO - PROCESS | 2666 | __startTimestamp1470083522196__endTimestamp 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | ------- Summary: start ------- 13:32:02 INFO - PROCESS | 2666 | Number of tests: 14 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:3.20 (2.9%) stddev-sans-first:1.39 13:32:02 INFO - PROCESS | 2666 | Values: 101.0 111.0 112.0 111.0 110.0 112.0 110.0 109.0 108.0 109.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:129.50 stddev:19.95 (15.4%) stddev-sans-first:20.96 13:32:02 INFO - PROCESS | 2666 | Values: 138.0 115.0 115.0 171.0 121.0 120.0 140.0 115.0 155.0 114.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 13:32:02 INFO - PROCESS | 2666 | Values: 159.0 161.0 159.0 161.0 159.0 159.0 160.0 160.0 161.0 159.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.00 stddev:19.55 (25.7%) stddev-sans-first:20.50 13:32:02 INFO - PROCESS | 2666 | Values: 76.0 76.0 77.0 131.0 76.0 75.0 73.0 74.0 109.0 76.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.00 stddev:19.72 (23.8%) stddev-sans-first:20.53 13:32:02 INFO - PROCESS | 2666 | Values: 84.0 83.0 124.0 83.0 83.0 82.0 111.0 83.0 82.0 132.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 13:32:02 INFO - PROCESS | 2666 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 118.0 117.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 13:32:02 INFO - PROCESS | 2666 | Values: 145.0 145.0 145.0 146.0 148.0 145.0 146.0 146.0 146.0 146.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:32:02 INFO - PROCESS | 2666 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:1.26 (2.5%) stddev-sans-first:1.32 13:32:02 INFO - PROCESS | 2666 | Values: 50.0 51.0 53.0 51.0 50.0 51.0 49.0 49.0 50.0 52.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 13:32:02 INFO - PROCESS | 2666 | Values: 62.0 63.0 64.0 64.0 63.0 62.0 63.0 62.0 63.0 62.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:3.86 (5.2%) stddev-sans-first:3.97 13:32:02 INFO - PROCESS | 2666 | Values: 72.0 72.0 73.0 72.0 82.0 75.0 72.0 72.0 81.0 76.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:123.50 stddev:12.98 (10.5%) stddev-sans-first:13.69 13:32:02 INFO - PROCESS | 2666 | Values: 122.0 130.0 124.0 115.0 123.0 116.0 121.0 116.0 159.0 132.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:153.00 stddev:1.84 (1.2%) stddev-sans-first:1.86 13:32:02 INFO - PROCESS | 2666 | Values: 154.0 153.0 152.0 152.0 150.0 152.0 153.0 155.0 149.0 154.0 13:32:02 INFO - PROCESS | 2666 | 13:32:02 INFO - PROCESS | 2666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:2.25 (3.7%) stddev-sans-first:1.01 13:32:02 INFO - PROCESS | 2666 | Values: 67.0 61.0 61.0 60.0 61.0 62.0 61.0 59.0 59.0 61.0 13:32:02 INFO - PROCESS | 2666 | -------- Summary: end -------- 13:32:02 INFO - PROCESS | 2666 | 13:32:03 INFO - TEST-INFO | 2666: exit 0 13:32:03 INFO - TEST-OK | kraken | took 59901ms 13:32:03 INFO - SUITE-END | took 1173s 13:32:03 INFO - Completed test suite (00:19:34) 13:32:03 INFO - javascript benchmark 13:32:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3198.136503144151, 3225.6451790303063, 3235.110344655219, 3257.4950882613202, 3278.7213086887614, 5618.101103823389, 5670.631408958415, 5704.629199102061, 5716.0, 5736.368999410061, 5672.971635141829, 5735.541156707463, 5739.253896993396, 5748.511376532989, 5749.856253593663, 5033.874153146164, 5115.769790359424, 5222.973885130569, 5223.921641175385, 5258.737063146847, 5167.534921857032, 5229.633925625208, 5231.529162375386, 5235.397929238129, 5242.135047717122, 5131.923021154686, 5208.817691380802, 5227.424983251858, 5240.082985477546, 5255.395629502599, 5309.017831701148, 5313.362396512404, 5317.0, 5323.600729945269, 5350.331208598945, 5052.368453943257, 5066.316047333599, 5151.227315902607, 5209.062368773619, 5213.504717051874, 5600.887982240373, 5647.0, 5664.603477756558, 5682.0, 5704.001799685038, 6157.568970172089, 6173.475254603364, 6176.536759743038, 6178.0, 6179.443850053517, 5888.057910734305, 5966.164736936832, 6045.576809623284, 6097.237845269341, 6192.071189321593, 5726.713664316809, 5743.597948143632, 5750.683712395775, 5755.453231942959, 5757.712114394305, 6195.473384762256, 6239.906401403891, 6256.718447669866, 6257.812265632038, 6260.46786023184, 5821.854453638693, 5993.730282137314, 6045.486133678599, 6053.273607167168, 6140.539459540552, 6198.907016394758, 6203.31763506014, 6205.875882482325, 6207.565470417027, 6211.844703882439, 6166.753329866845, 6171.56799024073, 6171.722272497748, 6174.104754810617, 6174.9691251544355, 5990.251218597676, 5990.281166260077, 6037.124616930609, 6099.969500152471, 6141.792871882685, 4658.743769092733, 4696.694714843524, 4699.083678682692, 4720.905581888343, 4758.5241475852135, 4186.644135248477, 4199.307114326163, 4200.5169405518145, 4205.663546916239, 4223.809928553223, 5542.057850165482, 5608.887822243532, 5724.8282551523525, 5761.962846687637, 5860.120981852756, 6151.231096112986, 6152.384761523901, 6154.9384506154365, 6160.10678451622, 6173.753049877954, 5781.0, 5793.420657934173, 5803.680797556175, 5816.767329306865, 5833.88332233353, 5124.487551244845, 5195.142801437721, 5200.5059519345605, 5221.660592061504, 5249.107651699221, 6404.48764098871, 6407.070974708734, 6416.807495775134, 6420.357964203636, 6440.291567927524, 6122.112293717475, 6134.938650613437, 6164.815055548341, 6169.629822210682, 6177.567570270217, 6072.848178795565, 6290.370962903673, 6301.716422761078, 6345.587536810092, 6396.392342727433, 6072.574919755575, 6073.058675905242, 6082.695865206633, 6100.23747031621, 6121.816345509642, 6168.722407491584, 6191.071339299141, 6201.720922558406, 6202.4417802398, 6204.348543403058, 5728.713564321684, 5945.64326140433, 5971.253593300838, 6017.699115044143, 6059.33347331802, 5992.43071908168, 6033.9698301508215, 6054.606450580698, 6055.636661800306, 6067.484263837623, 5933.851653708692, 5981.7308221131025, 5983.222181116427, 5984.491318237999, 6006.759729610942, 5886.117082437498, 5919.4376534230905, 5933.317668468181, 5969.552283578662, 6072.72672729737, 5890.587658863838, 5901.173835663097, 5903.734331955158, 5909.23179986599, 5927.881442371215], "value": 5644.04249000721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.6354055796243, 649.8927676933306, 664.0039940089864, 671.2884342596844, 677.1873751498204, 34589.308213835706, 45696.77151614241, 46322.073558528806, 46331.76834115825, 46338.53661463384, 48658.27012594814, 49133.50866491334, 49157.50842491574, 49215.0, 49232.2615160772, 8558.657653693845, 9360.251179905608, 9496.810063798719, 9508.429494230368, 9515.238780897545, 8480.151984801501, 8788.780280493007, 10978.341299522015, 11234.662960111209, 11245.60640377587, 11365.374904380256, 11410.144239182053, 11417.143714221425, 11424.657260282205, 11426.028787553027, 11290.830637540443, 11343.602973895957, 11346.092312615054, 11355.318680879174, 11361.659150225507, 11183.664490065312, 11229.0, 11240.550377984871, 11248.662540123809, 11252.437378131142, 46209.76895115536, 46497.767511162565, 46540.534594654295, 46570.0, 46595.53404465946, 3838.692904567628, 3948.2695701295065, 4165.312723400635, 4285.0, 4524.68327217095, 35985.46021809675, 36020.81989590035, 36075.81962090199, 36177.0, 37248.0, 4549.45406551216, 4741.952580474185, 4785.282207668843, 4802.375691160162, 4807.567318941277, 363812.0, 364185.0, 364420.0, 365368.17315913516, 365870.0, 65184.0, 65704.34295657078, 65716.67141664261, 65780.34219657742, 65853.0, 38929.80535097307, 39370.0, 39500.2099958005, 41842.0, 68353.0, 18320.63358732818, 18361.3573524926, 18408.907955460138, 18465.90767046156, 18467.445976620722, 12852.293123878277, 13537.66155846092, 14014.439422423193, 14125.293735313193, 14217.218053007184, 20212.191512339636, 21262.149514019267, 21295.254666086614, 21481.892590536947, 21514.89242553777, 7533.849323013509, 7641.312281894656, 7739.380849532024, 7760.88358674609, 7808.609569521501, 1065.6376831877199, 1131.9094472442184, 1146.9655910322704, 1182.3201659046083, 1205.3129716061935, 34599.0, 34791.82604086964, 35271.11822204414, 35283.294334113176, 35324.64675353265, 1189.4469071881617, 1192.7316353820322, 1201.0391686650644, 1254.6173417107686, 1260.9558665446666, 17499.737503937453, 18576.628467430575, 18678.719819202724, 18681.813181868278, 18871.811281887007, 582696.0, 592370.0, 592559.0, 593181.0, 594626.0, 64312.0, 65119.0, 65157.67421162864, 65207.0, 65266.0, 1338.2104558310448, 1406.4022790314075, 1466.3401469338628, 1470.125275461099, 1491.7911492391074, 33577.16057098592, 35260.647393526764, 35473.645263547034, 35842.462363064056, 35942.640573593926, 54037.027963460816, 54668.0, 54672.17991730048, 54694.17958730543, 54699.17951230815, 420390.0, 423821.0, 425643.0, 425934.0, 427049.0, 27914.860425698553, 28550.0, 28778.0, 28832.279193020342, 32893.0, 52904.20643690271, 52929.47070529399, 53162.0, 53895.73052134714, 54023.0, 44548.109037818416, 45183.32225016561, 45298.77350613226, 45544.0, 46816.7659161702, 44616.217128615215, 45898.08203835838, 46621.53378466172, 46822.53177468182, 47293.52706473029, 44074.77962610166, 44081.55918440903, 44263.336049958634, 45019.0, 45030.09939801251, 38682.80658596689, 40114.0, 40350.798246008584, 40875.36021261796, 40918.1816363677, 29062.564061539517, 29227.85386073056, 29564.408711825214, 29667.554986674786, 29902.102936911928], "value": 21976.09408009945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.5629029921938, 408.2202992284735, 417.9226843034038, 419.46937124537465, 426.98719038428857, 15760.0, 19946.0, 20269.695954560673, 20640.277590284342, 21992.670109948365, 20911.372658820223, 20969.580608387823, 21023.789762102373, 21226.257081002168, 21327.466813329636, 5528.115501519757, 5908.054711246202, 5954.70226488676, 5964.463198312151, 5966.403359664042, 4373.387725718402, 4443.755593442359, 5892.764289428418, 5967.671778052206, 5972.193753843219, 6476.384743449365, 6573.948168293074, 6574.3754343337305, 6575.408213260829, 6578.111954886077, 6379.138816259792, 6541.542092053558, 6570.63861487618, 6571.244306904719, 6581.967090164567, 5864.354920958691, 5865.35481097079, 5867.11993201019, 5868.2664666916635, 5869.79455719052, 23589.882050589807, 23698.170564030348, 23757.0, 23805.166819161248, 23853.7614623855, 2657.5349313869997, 2796.986015069932, 2840.8863645454157, 2855.214815925637, 2875.353045564752, 10559.577616895393, 11075.224734268604, 11130.38782866942, 15807.920960395239, 16013.519594412186, 2068.5449201175866, 2099.391176558796, 2159.2982280758815, 2182.159868450658, 2182.181681869299, 69617.65191174012, 73605.63197184034, 75392.0, 75707.24292757057, 87261.56369218176, 11468.827967580493, 11471.139664525193, 11664.533418663159, 11838.526458941546, 11865.940670296593, 15949.521514354588, 15958.361665533248, 15984.120873352078, 16050.518484445485, 16071.35714571404, 8485.448445851, 8735.432196907308, 8747.475151490931, 8751.693690720795, 8933.19601235892, 8498.320134389234, 8559.272461840814, 8568.657253709782, 8684.696035638723, 8735.213830755136, 4807.927881081787, 4816.543562783006, 4860.222364421676, 4988.575971042429, 5035.546800787946, 1977.4759688682511, 1981.8315443187203, 2021.545152340741, 2055.424481145282, 2058.588282343507, 488.272474013717, 489.1073790332657, 742.3912293328385, 983.188869182927, 1009.2682804966487, 12165.391730413445, 12708.0, 12867.356632168354, 12872.678183045311, 12915.160514566523, 486.99513004870204, 496.1614870868293, 504.50054446098096, 524.3314773663609, 531.6544246239974, 6788.151481064867, 6801.081853949752, 6906.965465172642, 6940.375366217065, 6985.476089293324, 546404.0, 548617.0, 549890.0, 553041.0, 555655.0, 68532.3146768536, 98902.5054874721, 101879.490602548, 102534.48732756288, 104535.0, 499.34835040272065, 509.4243504839508, 510.2321006884689, 510.7931287828361, 511.1591432094184, 11889.940550297193, 17804.55488612795, 18812.52968675794, 18815.153318100445, 20011.0, 45866.541334586225, 46024.30963535616, 46139.3079103807, 46940.53059469361, 48181.03637927292, 53231.46768532265, 60350.69824650849, 62213.0, 62522.37477625166, 63035.68482157743, 8743.737687869374, 9164.770880728036, 9206.0, 9343.81312373735, 9372.1565059145, 12286.815697764361, 13536.323183840965, 13612.65968350799, 14043.789343159657, 14112.36494357777, 10577.0, 11626.244294120856, 11960.521579136737, 12193.756124877631, 12529.18560293578, 5566.118075772796, 5726.5418766499415, 8534.274586660204, 10528.052475277262, 10593.576256949636, 11571.305721656727, 11573.074154067823, 11716.0, 11838.940805295919, 11987.700307492383, 7714.0, 9078.500682462529, 9136.63453461854, 9185.265178785814, 9557.139857412867, 8840.469571825453, 12029.819552706891, 12269.263844169378, 12331.568395106127, 12416.875831241934], "value": 8924.601961819828, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1562.7499600063984, 1613.2982152763548, 1818.8363047325738, 1842.649896519662, 1934.2649793078629, 9198.54007299635, 9918.752031199223, 9923.20614350852, 9926.652567160141, 9936.254780891426, 8241.299489543397, 9119.179273865351, 9340.299477539194, 9379.812403751921, 9664.661736839213, 2398.100712232917, 2450.105711415338, 2451.595486744685, 2452.766987136219, 2453.766892145243, 2396.928092157238, 2420.419099416145, 2449.1183174057323, 2456.0421435640023, 2459.803215742745, 2212.1372664660794, 2377.7384487706427, 2424.7090349158125, 2447.290285817111, 2466.0998735461517, 2436.0377650827913, 2449.4856080223176, 2451.1298489036494, 2453.7914277286454, 2455.26342097371, 2461.876906154685, 2479.454520005614, 2480.454300053985, 2484.8260621756485, 2486.3784053986506, 9711.320207585472, 9775.560099795526, 9818.607255709763, 9904.653337133166, 9918.90081099187, 5550.111982082847, 5688.914666280009, 5698.173764804122, 5700.515456186229, 5702.258706368187, 3507.8947631571095, 3593.4609808528667, 3645.908852278714, 3664.486971823947, 3667.0832291927018, 1159.232170939316, 1172.4020749417773, 1198.6044605280324, 1219.6402061391912, 1229.7356068445326, 13499.730005399935, 13640.045196836225, 13670.658233544142, 13680.65798355039, 13683.931580342134, 4642.134826075686, 4716.434027916672, 4788.808447662054, 4886.853394398174, 4916.139675556835, 10727.892721072845, 10728.624498142528, 10736.409497477714, 10743.409112498732, 10745.247832651796, 5609.523190528769, 5654.6324488908085, 5662.065759149694, 5668.546516278688, 5670.5747068969995, 5224.686518808883, 5257.316548848702, 5261.158214685632, 5298.178782288752, 5336.573074154058, 3921.8235179416993, 4012.6388625023305, 4020.19596080785, 4062.187562487455, 4134.338505839051, 1057.3814318623538, 1195.3485350484007, 1195.647284051207, 1195.7907366210877, 1203.48851738011, 992.7518120469882, 1093.8413929980109, 1099.3294090604725, 1110.3005106782675, 1115.2806439846415, 6401.967990160112, 6685.799426017227, 6694.799156025327, 6791.728330866808, 6805.421539169127, 514.2594663684283, 529.7907326606046, 545.4490964126261, 547.9369872464638, 698.1656919980575, 4514.571115743999, 4630.21286381316, 4658.953410465852, 4721.622270218443, 4780.545848144421, 11999.760004799855, 12111.515539378503, 12305.56930507428, 12438.626841194779, 12539.87460125387, 12104.15270931044, 12312.507499699912, 12329.198602090835, 12334.629961101182, 12380.504779808707, 9110.27117830572, 9144.588493517807, 9208.723738287863, 9236.26109911192, 9241.399309044891, 6520.478361730955, 6562.704678289393, 6590.077389165616, 6677.3656502632175, 6686.364795344434, 11010.284331518425, 11312.660620181408, 11409.60066397672, 11460.484278207334, 11538.423078845855, 11288.604898828502, 11394.487248074023, 11495.712607184887, 11553.24903881245, 11615.431916691476, 7781.144074151952, 7844.097928738268, 8372.497650141011, 8603.35474839402, 8621.094785047731, 9615.2307815376, 9689.27330450205, 9693.321467497208, 9697.854532181882, 9699.224062074876, 8465.703700370705, 8518.403711740119, 8663.826723465621, 8682.262007729414, 8898.688545900863, 8406.789830254293, 8498.065212826708, 8500.74497765068, 8589.355798315026, 8740.912590874264, 7955.2840244378285, 7962.92037079645, 7992.0, 8016.1182269949095, 8019.0, 5774.133879918046, 5877.94122058774, 5883.61756485827, 5888.116782482662, 6066.059760737093, 5884.7940322088525, 5897.7935772247765, 5914.704264786657, 5926.0, 6244.812655620339], "value": 4975.3099249396555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.78296781543713, 346.3626926455322, 351.9841607127679, 362.3188405797101, 362.6138162856559, 5452.182172674101, 5482.259894914186, 5590.217369568259, 5655.5475561955045, 5675.091985282355, 5407.756650950707, 5472.151816468454, 5497.285352904127, 5551.361593416758, 5554.1946417769395, 4384.934225986613, 4394.209042372372, 4403.163398954189, 4426.778661066934, 4440.0, 4238.258304796664, 4353.912921741563, 4388.802503887317, 4408.16244913467, 4487.708298960573, 4382.605565499104, 4391.736495810262, 4396.1427521633295, 4421.491528474218, 4442.666799989997, 4364.781760911942, 4395.956040439587, 4397.274449715809, 4407.845725399612, 4425.291953287458, 3824.2542704172697, 3885.3977633466857, 3923.784191869446, 3932.370820668708, 3963.2667956428154, 5383.488568585978, 5384.91922621161, 5394.599403265548, 5410.91883621746, 5437.483439073281, 5058.392992840846, 5062.265971434158, 5062.367204099488, 5093.363329583802, 5102.770375333119, 5555.0, 5774.393688662672, 5787.33445653751, 5802.419758024206, 5823.38854420284, 4327.723321620129, 4338.240807858644, 4355.281378572563, 4356.150550642626, 4362.47650281965, 5974.880502389971, 6039.54703397247, 6117.143599896018, 6150.2927163376335, 6157.9384206158265, 4395.846145384896, 4406.25093734066, 4420.58004489573, 4433.933490997638, 4462.947044359631, 4465.4864690561, 4477.888052798641, 4510.932336014962, 4519.977400112978, 4533.954660453419, 4857.125717370836, 5051.26756620288, 5056.418511871182, 5066.847994560169, 5081.618878584121, 5503.862403439866, 5795.159701843209, 5805.709714514342, 5821.388754180834, 5829.358770535237, 1507.7636338202788, 1546.8994515356467, 1552.5808031831343, 1566.6396728752222, 1571.5599632103028, 977.8875429325576, 1004.4073996342047, 1016.2530540053056, 1028.547439126782, 1029.9897001029894, 5013.373328333958, 5018.666320161143, 5033.949660503421, 5038.370203724535, 5067.417247016567, 5268.815591454358, 5269.604779641542, 5289.312389389354, 5295.761690723926, 5319.601029922771, 4626.362973105298, 4957.851264462072, 4960.627952903475, 4976.253561965662, 5038.496150384932, 2813.338865366637, 2821.9858900705367, 2824.5198316286283, 2825.954396873129, 2829.221963959886, 5460.180972854024, 5531.474509921551, 5573.637713548687, 5575.219469274305, 5596.4403559644525, 5101.897962040738, 5336.67979921206, 5373.468561459965, 5374.758135883894, 5393.217983392465, 5404.594655400861, 5445.264889239902, 5488.463230295523, 5491.725413729378, 5498.780048798083, 5120.695819110603, 5238.895222095613, 5302.70835104073, 5309.415964244007, 5340.652857564246, 5061.949380506295, 5120.590352771695, 5154.61340399464, 5185.22221666753, 5220.833354157982, 5382.703951282717, 5462.371827239918, 5467.589930755289, 5487.835364939058, 5545.64310168185, 3915.0, 4027.637512623878, 4069.5726948669962, 4076.7553946763287, 4115.300398932129, 5241.353116676054, 5257.737113144404, 5309.65487243328, 5802.767889284381, 5858.9121163181735, 5839.89042082003, 5866.442687944638, 5896.292444906639, 5904.291485021825, 5913.497352725067, 5830.2129212555765, 5844.181814545882, 5896.113243762126, 5897.882042359043, 5911.231539899785, 5635.295588051494, 5762.308522977102, 5773.624714393551, 5807.274090738658, 5817.970910145422, 5837.357890632112, 5837.883242335214, 5892.852678682896, 5898.439648233411, 5907.409259074058, 5620.718964051863, 5733.455321744427, 5746.569007324551, 5792.4497172768515, 5802.50678692299], "value": 4324.466425281852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.7202751064636, 860.2902605350583, 886.7605746448459, 900.2123142250531, 915.53765348499, 17102.05938673374, 17837.464876053724, 18105.547361315974, 18184.181711822966, 18215.72676409855, 16238.431654892081, 16439.0, 16471.34114635416, 16486.25811838467, 16488.0, 730.8538292341526, 860.3590325207714, 873.2577309287087, 883.0683628771643, 883.8718385834051, 893.5710858787786, 896.1038961038961, 896.9775755606097, 897.0536084430922, 897.3897749530316, 922.1608336413865, 922.6401703335705, 923.4274749655223, 924.2836801478874, 924.4684306523742, 772.2624893226982, 928.4893308680232, 930.6975233049286, 935.864299676543, 941.8869735631733, 661.3221448015775, 663.4062514049947, 664.1432552007903, 664.8537321789198, 668.7325069972002, 16268.83731162685, 16297.103659298733, 16297.83702162975, 16348.182590870409, 16350.0, 15611.765823512656, 15955.256384874328, 16050.277737501841, 16981.830181698147, 17465.0, 14741.189234592093, 14785.630359240997, 14841.851581484263, 14858.108513489226, 14957.102573845605, 4804.4234691836855, 4826.758662066918, 4837.226043833005, 4841.2496063110275, 4881.438634557036, 83030.58484707538, 83235.0, 83323.16676833214, 83354.74967875547, 83708.0, 12318.445669944875, 13209.471621135048, 13356.398962046536, 13426.0, 14001.5099471518, 23552.0, 24136.396590085387, 24963.375915601893, 25306.493870122493, 25398.365040874127, 9440.291978101532, 9697.806043879084, 9736.707898762907, 9839.311248212556, 9919.950400247953, 5029.421616514074, 5178.715170665574, 5188.040212560688, 5192.532672059458, 5325.8934821303355, 3914.5693973662874, 4015.19696060789, 4049.0484736086996, 4108.424820525129, 4115.773632450184, 697.6058526932369, 698.4063545985871, 704.9471289653296, 712.3659942651045, 718.8849784034529, 595.9910601340983, 721.6463932672953, 783.7296132834163, 799.5122974985254, 829.5769157729601, 10238.283320167666, 10716.249862509705, 10987.725306867393, 11274.887251127548, 11281.548738050551, 688.4389222783416, 712.3588770106842, 745.4632664481564, 797.9840403191904, 810.8986376702912, 4912.852614421573, 5139.100657384943, 5152.3044389007, 5293.073712100367, 5307.65500242483, 79292.6035369831, 112484.0, 113239.43380283046, 114148.42925785483, 116572.41713791377, 101715.49142254241, 102812.0, 104706.0, 104719.4764026175, 105188.0, 83365.0, 88682.0, 88747.0, 89539.55230223807, 90253.0, 10771.946140269249, 11286.829389171107, 11310.94344528272, 11353.489092991, 11450.370229637118, 53678.463215367345, 54518.45481545134, 54564.18153727618, 55719.16421253765, 57907.0, 73414.63292683502, 78185.2181478178, 82598.58700706458, 84361.0, 84443.57778211315, 14145.080569762933, 14413.13521188732, 14575.562733118024, 14751.262436878327, 14778.852211477748, 16190.514284571482, 16332.101734404721, 16526.917365413097, 17666.911665441592, 17703.29186832564, 14881.404743810559, 15013.549593512213, 15090.698186035997, 15174.317155727798, 16437.0, 13199.274039927896, 13803.378847951666, 14071.718565628425, 14757.114573125647, 14818.77771833445, 13123.934380328037, 13306.933465332611, 13307.86692133105, 13837.100588461717, 13880.167189968633, 11707.531698731955, 11804.40977951082, 11980.46087926028, 11999.460024298753, 12617.306048167438, 12344.4444999977, 12411.255324680547, 12762.17045892014, 12829.61511154667, 13002.869971300166], "value": 8329.779559627215, "unit": "score"}], "name": "dromaeo_css", "value": 7637.067659032872, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 111.0, 110.0, 112.0, 110.0, 109.0, 108.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 115.0, 115.0, 171.0, 121.0, 120.0, 140.0, 115.0, 155.0, 114.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 159.0, 161.0, 159.0, 159.0, 160.0, 160.0, 161.0, 159.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 131.0, 76.0, 75.0, 73.0, 74.0, 109.0, 76.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 124.0, 83.0, 83.0, 82.0, 111.0, 83.0, 82.0, 132.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 148.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 53.0, 51.0, 50.0, 51.0, 49.0, 49.0, 50.0, 52.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 64.0, 63.0, 62.0, 63.0, 62.0, 63.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 72.0, 82.0, 75.0, 72.0, 72.0, 81.0, 76.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 124.0, 115.0, 123.0, 116.0, 121.0, 116.0, 159.0, 132.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 152.0, 152.0, 150.0, 152.0, 153.0, 155.0, 149.0, 154.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 61.0, 61.0, 60.0, 61.0, 62.0, 61.0, 59.0, 59.0, 61.0], "value": 61.2, "unit": "score"}], "name": "kraken", "value": 1463.2000000000003, "alertThreshold": 2.0}]} 13:32:03 INFO - Return code: 0 13:32:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:32:03 INFO - # TBPL SUCCESS # 13:32:03 INFO - Running post-action listener: _resource_record_post_action 13:32:03 INFO - [mozharness: 2016-08-01 20:32:03.507973Z] Finished run-tests step (success) 13:32:03 INFO - Running post-run listener: _resource_record_post_run 13:32:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521818112; Read time: 8; Write time: 499076 13:32:03 INFO - TinderboxPrint: CPU usage
13.0% 13:32:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:32:03 INFO - TinderboxPrint: I/O write bytes / time
521,818,112 / 499,076 13:32:03 INFO - TinderboxPrint: CPU idle
8,258.5 (86.9%) 13:32:03 INFO - TinderboxPrint: CPU user
1,192.8 (12.6%) 13:32:03 INFO - TinderboxPrint: Swap in / out
0 / 0 13:32:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251437056; Read time: 0; Write time: 272368 13:32:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 254418944; Read time: 0; Write time: 219504 13:32:04 INFO - Running post-run listener: _upload_blobber_files 13:32:04 INFO - Blob upload gear active. 13:32:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:32:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:32:04 INFO - (blobuploader) - INFO - Open directory for files ... 13:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:05 INFO - (blobuploader) - INFO - Done attempting. 13:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:09 INFO - (blobuploader) - INFO - Done attempting. 13:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:10 INFO - (blobuploader) - INFO - Done attempting. 13:32:10 INFO - (blobuploader) - INFO - Iteration through files over. 13:32:10 INFO - Return code: 0 13:32:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:32:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:32:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09b106fce9329e361d1238c64944ccf5e8485e3004e7b14d468135ecc5f6fa7845d5a8352246e96970b725189c3f04b0ac9130c0c48436f0402eafd7f0066ca6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fb808b5a2bb5051588787bbbb9df68ba43a2977b5748c4d3ef871259edc727128eefcb563466be702555c815b97687844662294828bf154bb46a845c2bf7daf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea4afd53d8beeaa65632e112ef1947cee50e8a4578f8d843290525ffb3d8f7aaa2ef4321dc20a40bc63c5081e2284e9ff39d4195247aa4ebe9be901f0a8b15a"} 13:32:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:32:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:32:10 INFO - Contents: 13:32:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09b106fce9329e361d1238c64944ccf5e8485e3004e7b14d468135ecc5f6fa7845d5a8352246e96970b725189c3f04b0ac9130c0c48436f0402eafd7f0066ca6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fb808b5a2bb5051588787bbbb9df68ba43a2977b5748c4d3ef871259edc727128eefcb563466be702555c815b97687844662294828bf154bb46a845c2bf7daf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea4afd53d8beeaa65632e112ef1947cee50e8a4578f8d843290525ffb3d8f7aaa2ef4321dc20a40bc63c5081e2284e9ff39d4195247aa4ebe9be901f0a8b15a"} 13:32:10 INFO - Running post-run listener: copy_logs_to_upload_dir 13:32:10 INFO - Copying logs to upload dir... 13:32:10 INFO - mkdir: /builds/slave/test/build/upload/logs 13:32:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.460197 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-08-01 13:32:10.119734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 13:32:10.123641) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438 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/09b106fce9329e361d1238c64944ccf5e8485e3004e7b14d468135ecc5f6fa7845d5a8352246e96970b725189c3f04b0ac9130c0c48436f0402eafd7f0066ca6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fb808b5a2bb5051588787bbbb9df68ba43a2977b5748c4d3ef871259edc727128eefcb563466be702555c815b97687844662294828bf154bb46a845c2bf7daf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea4afd53d8beeaa65632e112ef1947cee50e8a4578f8d843290525ffb3d8f7aaa2ef4321dc20a40bc63c5081e2284e9ff39d4195247aa4ebe9be901f0a8b15a"} build_url:https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/c1hDH1BSSNeJhKIm4uidrA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09b106fce9329e361d1238c64944ccf5e8485e3004e7b14d468135ecc5f6fa7845d5a8352246e96970b725189c3f04b0ac9130c0c48436f0402eafd7f0066ca6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fb808b5a2bb5051588787bbbb9df68ba43a2977b5748c4d3ef871259edc727128eefcb563466be702555c815b97687844662294828bf154bb46a845c2bf7daf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea4afd53d8beeaa65632e112ef1947cee50e8a4578f8d843290525ffb3d8f7aaa2ef4321dc20a40bc63c5081e2284e9ff39d4195247aa4ebe9be901f0a8b15a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 13:32:10.148682) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:32:10.149021) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470082299.923278-941193438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 13:32:10.231991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 13:32:10.232316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 13:32:10.232615) ========= ========= Total master_lag: 0.17 =========