builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1469746198.67 results: success (0) buildid: 20160728142528 builduid: 6619623a4b5941b89ab8e6381fd103ca revision: 4c84eea22241b1ab95b64fee3596484ebdf78d24 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:58.675132) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:58.675591) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:58.675868) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:58.693561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:58.693845) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 15:49:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-07-28 15:49:59 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106101 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:58.819625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:58.820010) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015999 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:58.870756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:58.871329) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4c84eea22241b1ab95b64fee3596484ebdf78d24 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4c84eea22241b1ab95b64fee3596484ebdf78d24 --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=3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 15:49:59,326 truncating revision to first 12 chars 2016-07-28 15:49:59,326 Setting DEBUG logging. 2016-07-28 15:49:59,326 attempt 1/10 2016-07-28 15:49:59,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4c84eea22241?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 15:49:59,636 unpacking tar archive at: autoland-4c84eea22241/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:59.553788) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:59.554169) ========= script_repo_revision: 4c84eea22241b1ab95b64fee3596484ebdf78d24 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:59.554655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:59.554954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 15:49:59.567517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-28 15:49:59.567957) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:00 INFO - MultiFileLogger online at 20160728 15:50:00 in /builds/slave/test 15:50:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 15:50:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:00 INFO - {'append_to_log': False, 15:50:00 INFO - 'base_work_dir': '/builds/slave/test', 15:50:00 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:50:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:00 INFO - 'branch': 'Autoland-Non-PGO', 15:50:00 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:00 INFO - 'config_files': ('talos/linux_config.py',), 15:50:00 INFO - 'default_actions': ('clobber', 15:50:00 INFO - 'read-buildbot-config', 15:50:00 INFO - 'download-and-extract', 15:50:00 INFO - 'populate-webroot', 15:50:00 INFO - 'create-virtualenv', 15:50:00 INFO - 'install', 15:50:00 INFO - 'run-tests'), 15:50:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:00 INFO - 'download_minidump_stackwalk': True, 15:50:00 INFO - 'download_symbols': 'ondemand', 15:50:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:00 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:00 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:00 INFO - 'installer_path': 'installer.exe', 15:50:00 INFO - 'log_level': 'info', 15:50:00 INFO - 'log_name': 'talos', 15:50:00 INFO - 'log_to_console': True, 15:50:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:00 INFO - 'opt_config_files': (), 15:50:00 INFO - 'pip_index': False, 15:50:00 INFO - 'sps_profile': False, 15:50:00 INFO - 'sps_profile_interval': 0, 15:50:00 INFO - 'suite': 'dromaeojs', 15:50:00 INFO - 'system_bits': '32', 15:50:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:00 INFO - 'title': 'talos-linux64-ix-059', 15:50:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:00 INFO - 'use_talos_json': True, 15:50:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:00 INFO - 'work_dir': 'build'} 15:50:00 INFO - [mozharness: 2016-07-28 22:50:00.107466Z] Running clobber step. 15:50:00 INFO - Running pre-action listener: _resource_record_pre_action 15:50:00 INFO - Running main action method: clobber 15:50:00 INFO - rmtree: /builds/slave/test/build 15:50:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:00 INFO - Running post-action listener: _resource_record_post_action 15:50:00 INFO - [mozharness: 2016-07-28 22:50:00.576869Z] Finished clobber step (success) 15:50:00 INFO - [mozharness: 2016-07-28 22:50:00.576970Z] Running read-buildbot-config step. 15:50:00 INFO - Running pre-action listener: _resource_record_pre_action 15:50:00 INFO - Running main action method: read_buildbot_config 15:50:00 INFO - Using buildbot properties: 15:50:00 INFO - { 15:50:00 INFO - "project": "", 15:50:00 INFO - "product": "firefox", 15:50:00 INFO - "script_repo_revision": "production", 15:50:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:50:00 INFO - "repository": "", 15:50:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 15:50:00 INFO - "buildid": "20160728142528", 15:50:00 INFO - "pgo_build": "False", 15:50:00 INFO - "basedir": "/builds/slave/test", 15:50:00 INFO - "buildnumber": 152, 15:50:00 INFO - "slavename": "talos-linux64-ix-059", 15:50:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:50:00 INFO - "platform": "ubuntu64_hw", 15:50:00 INFO - "scheduler": "tests-autoland-linux64-talos", 15:50:00 INFO - "branch": "autoland", 15:50:00 INFO - "repo_path": "integration/autoland", 15:50:00 INFO - "revision": "4c84eea22241b1ab95b64fee3596484ebdf78d24", 15:50:00 INFO - "stage_platform": "linux64", 15:50:00 INFO - "builduid": "6619623a4b5941b89ab8e6381fd103ca", 15:50:00 INFO - "slavebuilddir": "test" 15:50:00 INFO - } 15:50:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:50:00 INFO - Running post-action listener: _resource_record_post_action 15:50:00 INFO - [mozharness: 2016-07-28 22:50:00.579433Z] Finished read-buildbot-config step (success) 15:50:00 INFO - [mozharness: 2016-07-28 22:50:00.579522Z] Running download-and-extract step. 15:50:00 INFO - Running pre-action listener: _resource_record_pre_action 15:50:00 INFO - Running main action method: download_and_extract 15:50:00 INFO - mkdir: /builds/slave/test/build/tests 15:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:00 INFO - https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:50:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:50:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:50:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:50:01 INFO - Downloaded 1361 bytes. 15:50:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:50:01 INFO - Using the following test package requirements: 15:50:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:50:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:01 INFO - u'jsshell-linux-x86_64.zip'], 15:50:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:50:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:50:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50: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')]} 15:50:01 INFO - https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:03 INFO - Downloaded 22749930 bytes. 15:50:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:50:04 INFO - Return code: 0 15:50:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:50:04 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')]} 15:50:04 INFO - https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:05 INFO - Downloaded 22749930 bytes. 15:50:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:50:07 INFO - Return code: 0 15:50:07 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')]} 15:50:07 INFO - https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:50:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:50:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:50:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:50:08 INFO - Downloaded 14413725 bytes. 15:50:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:50:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:50:08 INFO - Return code: 0 15:50: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')]} 15:50:08 INFO - https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:50:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:50:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:50:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:50:11 INFO - Downloaded 57164556 bytes. 15:50:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:50:11 INFO - mkdir: /builds/slave/test/properties 15:50:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:50:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:50:11 INFO - Contents: 15:50:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:50:12 INFO - Running post-action listener: _resource_record_post_action 15:50:12 INFO - Running post-action listener: set_extra_try_arguments 15:50:12 INFO - [mozharness: 2016-07-28 22:50:12.425051Z] Finished download-and-extract step (success) 15:50:12 INFO - [mozharness: 2016-07-28 22:50:12.425282Z] Running populate-webroot step. 15:50:12 INFO - Running pre-action listener: _resource_record_pre_action 15:50:12 INFO - Running main action method: populate_webroot 15:50:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:50:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:50:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:50:12 INFO - '--tppagecycles', 15:50:12 INFO - '7'], 15:50:12 INFO - 'tests': ['tsvgm']}}, 15:50:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:50:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:50:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:50:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:50:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:12 INFO - 'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:12 INFO - 'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['damp', 'tps']}, 15:50:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:12 INFO - 'tests': ['damp', 'tps']}, 15:50:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['dromaeo_dom']}, 15:50:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['basic_compositor_video']}, 15:50:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:50:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['a11yr', 15:50:12 INFO - 'ts_paint', 15:50:12 INFO - 'tpaint', 15:50:12 INFO - 'sessionrestore', 15:50:12 INFO - 'sessionrestore_no_auto_restore', 15:50:12 INFO - 'tabpaint']}, 15:50:12 INFO - 'other-e10s': {'tests': ['a11yr', 15:50:12 INFO - 'ts_paint', 15:50:12 INFO - 'tpaint', 15:50:12 INFO - 'sessionrestore', 15:50:12 INFO - 'sessionrestore_no_auto_restore', 15:50:12 INFO - 'tabpaint']}, 15:50:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:50:12 INFO - 'ts_paint', 15:50:12 INFO - 'tpaint', 15:50:12 INFO - 'sessionrestore', 15:50:12 INFO - 'sessionrestore_no_auto_restore', 15:50:12 INFO - 'tabpaint']}, 15:50:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:50:12 INFO - 'ts_paint', 15:50:12 INFO - 'tpaint', 15:50:12 INFO - 'sessionrestore', 15:50:12 INFO - 'sessionrestore_no_auto_restore', 15:50:12 INFO - 'tabpaint']}, 15:50:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['a11yr', 15:50:12 INFO - 'ts_paint', 15:50:12 INFO - 'tpaint', 15:50:12 INFO - 'sessionrestore', 15:50:12 INFO - 'sessionrestore_no_auto_restore', 15:50:12 INFO - 'tabpaint']}, 15:50:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['a11yr', 15:50:12 INFO - 'ts_paint', 15:50:12 INFO - 'tpaint', 15:50:12 INFO - 'sessionrestore', 15:50:12 INFO - 'sessionrestore_no_auto_restore', 15:50:12 INFO - 'tabpaint']}, 15:50:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['tsvgx', 15:50:12 INFO - 'tsvgr_opacity', 15:50:12 INFO - 'tart', 15:50:12 INFO - 'tscrollx', 15:50:12 INFO - 'cart']}, 15:50:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:50:12 INFO - 'tsvgr_opacity', 15:50:12 INFO - 'tart', 15:50:12 INFO - 'tscrollx', 15:50:12 INFO - 'cart']}, 15:50:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:12 INFO - 'talos_options': ['--disable-e10s'], 15:50:12 INFO - 'tests': ['tp5o']}, 15:50:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:12 INFO - 'tests': ['tp5o']}, 15:50:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:12 INFO - 'talos_options': ['--disable-e10s', 15:50:12 INFO - '--xperf_path', 15:50:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:12 INFO - 'tests': ['tp5n']}, 15:50:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:12 INFO - 'talos_options': ['--xperf_path', 15:50:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:12 INFO - 'tests': ['tp5n']}}, 15:50:12 INFO - 'talos.zip': {'path': '', 15:50:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:50:12 INFO - Running post-action listener: _resource_record_post_action 15:50:12 INFO - [mozharness: 2016-07-28 22:50:12.447330Z] Finished populate-webroot step (success) 15:50:12 INFO - [mozharness: 2016-07-28 22:50:12.447419Z] Running create-virtualenv step. 15:50:12 INFO - Running pre-action listener: _resource_record_pre_action 15:50:12 INFO - Running main action method: create_virtualenv 15:50:12 INFO - Creating virtualenv /builds/slave/test/build/venv 15:50:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:50:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:50:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:12 INFO - Using real prefix '/usr' 15:50:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:50:13 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:15 INFO - Installing pip.................done. 15:50:15 INFO - Return code: 0 15:50:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:50:15 INFO - Using env: {'DISPLAY': ':0', 15:50:15 INFO - 'HOME': '/home/cltbld', 15:50:15 INFO - 'LANG': 'en_US.UTF-8', 15:50:15 INFO - 'LANGUAGE': 'en_US:en', 15:50:15 INFO - 'LOGNAME': 'cltbld', 15:50:15 INFO - 'MAIL': '/var/mail/cltbld', 15:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:15 INFO - 'MOZ_NO_REMOTE': '1', 15:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:15 INFO - 'NO_EM_RESTART': '1', 15:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:15 INFO - 'PWD': '/builds/slave/test', 15:50:15 INFO - 'SHELL': '/bin/bash', 15:50:15 INFO - 'SHLVL': '1', 15:50:15 INFO - 'TERM': 'linux', 15:50:15 INFO - 'TMOUT': '86400', 15:50:15 INFO - 'USER': 'cltbld', 15:50:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:15 INFO - '_': '/tools/buildbot/bin/python'} 15:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:50:15 INFO - Cleaning up... 15:50:15 INFO - Return code: 0 15:50:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:50:15 INFO - Using env: {'DISPLAY': ':0', 15:50:15 INFO - 'HOME': '/home/cltbld', 15:50:15 INFO - 'LANG': 'en_US.UTF-8', 15:50:15 INFO - 'LANGUAGE': 'en_US:en', 15:50:15 INFO - 'LOGNAME': 'cltbld', 15:50:15 INFO - 'MAIL': '/var/mail/cltbld', 15:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:15 INFO - 'MOZ_NO_REMOTE': '1', 15:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:15 INFO - 'NO_EM_RESTART': '1', 15:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:15 INFO - 'PWD': '/builds/slave/test', 15:50:15 INFO - 'SHELL': '/bin/bash', 15:50:15 INFO - 'SHLVL': '1', 15:50:15 INFO - 'TERM': 'linux', 15:50:15 INFO - 'TMOUT': '86400', 15:50:15 INFO - 'USER': 'cltbld', 15:50:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:15 INFO - '_': '/tools/buildbot/bin/python'} 15:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:15 INFO - Downloading/unpacking psutil>=3.1.1 15:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:17 INFO - Installing collected packages: psutil 15:50:17 INFO - Running setup.py install for psutil 15:50:17 INFO - building 'psutil._psutil_linux' extension 15:50:17 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 15:50:17 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 15:50:17 INFO - building 'psutil._psutil_posix' extension 15:50:17 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 15:50:17 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 15:50:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:17 INFO - Successfully installed psutil 15:50:17 INFO - Cleaning up... 15:50:17 INFO - Return code: 0 15:50:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:50:17 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')]} 15:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:17 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')]} 15:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:17 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 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:17 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 15:50:17 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 15:50:17 INFO - Using env: {'DISPLAY': ':0', 15:50:17 INFO - 'HOME': '/home/cltbld', 15:50:17 INFO - 'LANG': 'en_US.UTF-8', 15:50:17 INFO - 'LANGUAGE': 'en_US:en', 15:50:17 INFO - 'LOGNAME': 'cltbld', 15:50:17 INFO - 'MAIL': '/var/mail/cltbld', 15:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:17 INFO - 'MOZ_NO_REMOTE': '1', 15:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:17 INFO - 'NO_EM_RESTART': '1', 15:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:17 INFO - 'PWD': '/builds/slave/test', 15:50:17 INFO - 'SHELL': '/bin/bash', 15:50:17 INFO - 'SHLVL': '1', 15:50:17 INFO - 'TERM': 'linux', 15:50:17 INFO - 'TMOUT': '86400', 15:50:17 INFO - 'USER': 'cltbld', 15:50:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:17 INFO - '_': '/tools/buildbot/bin/python'} 15:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:50:20 INFO - Installing collected packages: mozsystemmonitor 15:50:20 INFO - Running setup.py install for mozsystemmonitor 15:50:20 INFO - Successfully installed mozsystemmonitor 15:50:20 INFO - Cleaning up... 15:50:20 INFO - Return code: 0 15:50:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:50:20 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')]} 15:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:20 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')]} 15:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:20 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 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:20 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 15:50:20 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 15:50:20 INFO - Using env: {'DISPLAY': ':0', 15:50:20 INFO - 'HOME': '/home/cltbld', 15:50:20 INFO - 'LANG': 'en_US.UTF-8', 15:50:20 INFO - 'LANGUAGE': 'en_US:en', 15:50:20 INFO - 'LOGNAME': 'cltbld', 15:50:20 INFO - 'MAIL': '/var/mail/cltbld', 15:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:20 INFO - 'MOZ_NO_REMOTE': '1', 15:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:20 INFO - 'NO_EM_RESTART': '1', 15:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:20 INFO - 'PWD': '/builds/slave/test', 15:50:20 INFO - 'SHELL': '/bin/bash', 15:50:20 INFO - 'SHLVL': '1', 15:50:20 INFO - 'TERM': 'linux', 15:50:20 INFO - 'TMOUT': '86400', 15:50:20 INFO - 'USER': 'cltbld', 15:50:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:20 INFO - '_': '/tools/buildbot/bin/python'} 15:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:20 INFO - Downloading/unpacking jsonschema==2.5.1 15:50:20 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 15:50:20 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 15:50:20 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 15:50:20 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 15:50:20 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 15:50:20 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 15:50:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:50:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:50:22 INFO - warning: no files found matching '*.txt' 15:50:22 INFO - no previously-included directories found matching 'build' 15:50:22 INFO - no previously-included directories found matching 'dist' 15:50:22 INFO - no previously-included directories found matching '.git*' 15:50:22 INFO - Installing collected packages: jsonschema, functools32 15:50:22 INFO - Running setup.py install for functools32 15:50:22 INFO - warning: no files found matching '*.txt' 15:50:22 INFO - no previously-included directories found matching 'build' 15:50:22 INFO - no previously-included directories found matching 'dist' 15:50:22 INFO - no previously-included directories found matching '.git*' 15:50:22 INFO - Successfully installed jsonschema functools32 15:50:22 INFO - Cleaning up... 15:50:22 INFO - Return code: 0 15:50:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:50:22 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')]} 15:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:22 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')]} 15:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:22 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 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:22 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 15:50:22 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 15:50:22 INFO - Using env: {'DISPLAY': ':0', 15:50:22 INFO - 'HOME': '/home/cltbld', 15:50:22 INFO - 'LANG': 'en_US.UTF-8', 15:50:22 INFO - 'LANGUAGE': 'en_US:en', 15:50:22 INFO - 'LOGNAME': 'cltbld', 15:50:22 INFO - 'MAIL': '/var/mail/cltbld', 15:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:22 INFO - 'MOZ_NO_REMOTE': '1', 15:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:22 INFO - 'NO_EM_RESTART': '1', 15:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:22 INFO - 'PWD': '/builds/slave/test', 15:50:22 INFO - 'SHELL': '/bin/bash', 15:50:22 INFO - 'SHLVL': '1', 15:50:22 INFO - 'TERM': 'linux', 15:50:22 INFO - 'TMOUT': '86400', 15:50:22 INFO - 'USER': 'cltbld', 15:50:22 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:22 INFO - '_': '/tools/buildbot/bin/python'} 15:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:50:23 INFO - Cleaning up... 15:50:23 INFO - Return code: 0 15:50:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:50:23 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')]} 15:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:23 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')]} 15:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:23 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 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:23 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 15:50:23 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 15:50:23 INFO - Using env: {'DISPLAY': ':0', 15:50:23 INFO - 'HOME': '/home/cltbld', 15:50:23 INFO - 'LANG': 'en_US.UTF-8', 15:50:23 INFO - 'LANGUAGE': 'en_US:en', 15:50:23 INFO - 'LOGNAME': 'cltbld', 15:50:23 INFO - 'MAIL': '/var/mail/cltbld', 15:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:23 INFO - 'MOZ_NO_REMOTE': '1', 15:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:23 INFO - 'NO_EM_RESTART': '1', 15:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:23 INFO - 'PWD': '/builds/slave/test', 15:50:23 INFO - 'SHELL': '/bin/bash', 15:50:23 INFO - 'SHLVL': '1', 15:50:23 INFO - 'TERM': 'linux', 15:50:23 INFO - 'TMOUT': '86400', 15:50:23 INFO - 'USER': 'cltbld', 15:50:23 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:23 INFO - '_': '/tools/buildbot/bin/python'} 15:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:50:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:50:25 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 15:50:25 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 15:50:25 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 15:50:25 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 15:50:25 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 15:50:25 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 15:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:50:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:50:25 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 15:50:25 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 15:50:25 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 15:50:25 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 15:50:25 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 15:50:25 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 15:50:25 INFO - Downloading docopt-0.6.1.tar.gz 15:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:50:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:50:25 INFO - Running setup.py install for blobuploader 15:50:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:50:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:50:25 INFO - Running setup.py install for requests 15:50:26 INFO - Running setup.py install for docopt 15:50:26 INFO - Successfully installed blobuploader requests docopt 15:50:26 INFO - Cleaning up... 15:50:26 INFO - Return code: 0 15:50:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:26 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 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:26 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 15:50:26 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 15:50:26 INFO - Using env: {'DISPLAY': ':0', 15:50:26 INFO - 'HOME': '/home/cltbld', 15:50:26 INFO - 'LANG': 'en_US.UTF-8', 15:50:26 INFO - 'LANGUAGE': 'en_US:en', 15:50:26 INFO - 'LOGNAME': 'cltbld', 15:50:26 INFO - 'MAIL': '/var/mail/cltbld', 15:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:26 INFO - 'MOZ_NO_REMOTE': '1', 15:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:26 INFO - 'NO_EM_RESTART': '1', 15:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:26 INFO - 'PWD': '/builds/slave/test', 15:50:26 INFO - 'SHELL': '/bin/bash', 15:50:26 INFO - 'SHLVL': '1', 15:50:26 INFO - 'TERM': 'linux', 15:50:26 INFO - 'TMOUT': '86400', 15:50:26 INFO - 'USER': 'cltbld', 15:50:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:26 INFO - '_': '/tools/buildbot/bin/python'} 15:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:26 INFO - Running setup.py (path:/tmp/pip-JkbGvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:26 INFO - Running setup.py (path:/tmp/pip-PasAJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:26 INFO - Running setup.py (path:/tmp/pip-Ft18iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:26 INFO - Running setup.py (path:/tmp/pip-hL86mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:26 INFO - Running setup.py (path:/tmp/pip-2NA8Pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:27 INFO - Running setup.py (path:/tmp/pip-J9DOQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:27 INFO - Running setup.py (path:/tmp/pip-lV72lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:27 INFO - Running setup.py (path:/tmp/pip-17Q29X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:27 INFO - Running setup.py (path:/tmp/pip-G8zx5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:27 INFO - Running setup.py (path:/tmp/pip-rkZGxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:27 INFO - Running setup.py (path:/tmp/pip-lpbVws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:27 INFO - Running setup.py (path:/tmp/pip-Ey5jC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:27 INFO - Running setup.py (path:/tmp/pip-uuK8HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:27 INFO - Running setup.py (path:/tmp/pip-AaSTWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:27 INFO - Running setup.py (path:/tmp/pip-IwuXMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:27 INFO - Running setup.py (path:/tmp/pip-zwzzpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:27 INFO - Running setup.py (path:/tmp/pip-G3SRFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:50:27 INFO - Running setup.py install for manifestparser 15:50:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:50:27 INFO - Running setup.py install for mozcrash 15:50:28 INFO - Running setup.py install for mozdebug 15:50:28 INFO - Running setup.py install for mozdevice 15:50:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:50:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:50:28 INFO - Running setup.py install for mozfile 15:50:28 INFO - Running setup.py install for mozhttpd 15:50:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:50:28 INFO - Running setup.py install for mozinfo 15:50:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:50:28 INFO - Running setup.py install for mozInstall 15:50:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:50:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:50:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:50:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:50:28 INFO - Running setup.py install for mozleak 15:50:28 INFO - Running setup.py install for mozlog 15:50:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:50:28 INFO - Running setup.py install for moznetwork 15:50:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:50:29 INFO - Running setup.py install for mozprocess 15:50:29 INFO - Running setup.py install for mozprofile 15:50:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:50:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:50:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:50:29 INFO - Running setup.py install for mozrunner 15:50:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:50:29 INFO - Running setup.py install for mozscreenshot 15:50:29 INFO - Running setup.py install for moztest 15:50:29 INFO - Running setup.py install for mozversion 15:50:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:50:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:50:29 INFO - Cleaning up... 15:50:29 INFO - Return code: 0 15:50:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:29 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 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:29 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 15:50:29 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 15:50:29 INFO - Using env: {'DISPLAY': ':0', 15:50:29 INFO - 'HOME': '/home/cltbld', 15:50:29 INFO - 'LANG': 'en_US.UTF-8', 15:50:29 INFO - 'LANGUAGE': 'en_US:en', 15:50:29 INFO - 'LOGNAME': 'cltbld', 15:50:29 INFO - 'MAIL': '/var/mail/cltbld', 15:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:29 INFO - 'MOZ_NO_REMOTE': '1', 15:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:29 INFO - 'NO_EM_RESTART': '1', 15:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:29 INFO - 'PWD': '/builds/slave/test', 15:50:29 INFO - 'SHELL': '/bin/bash', 15:50:29 INFO - 'SHLVL': '1', 15:50:29 INFO - 'TERM': 'linux', 15:50:29 INFO - 'TMOUT': '86400', 15:50:29 INFO - 'USER': 'cltbld', 15:50:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:29 INFO - '_': '/tools/buildbot/bin/python'} 15:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:29 INFO - Running setup.py (path:/tmp/pip-y2d3TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:29 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)) 15:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:29 INFO - Running setup.py (path:/tmp/pip-YztgyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:30 INFO - Running setup.py (path:/tmp/pip-5d97IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:30 INFO - Running setup.py (path:/tmp/pip-uUcffg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:30 INFO - Running setup.py (path:/tmp/pip-BOZ4Eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:30 INFO - Running setup.py (path:/tmp/pip-j7bbD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:30 INFO - Running setup.py (path:/tmp/pip-x3o0Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:30 INFO - Running setup.py (path:/tmp/pip-7jOUYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:30 INFO - Running setup.py (path:/tmp/pip-V93AFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:30 INFO - Running setup.py (path:/tmp/pip-wBZoWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:30 INFO - Running setup.py (path:/tmp/pip-tzvbH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:30 INFO - Running setup.py (path:/tmp/pip-682Bdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:30 INFO - Running setup.py (path:/tmp/pip-DKk0ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:30 INFO - Running setup.py (path:/tmp/pip-sxGnOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:30 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)) 15:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:30 INFO - Running setup.py (path:/tmp/pip-fmRxyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:31 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)) 15:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:31 INFO - Running setup.py (path:/tmp/pip-DM_N9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:31 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)) 15:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:31 INFO - Running setup.py (path:/tmp/pip-98Wc4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:31 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)) 15:50:31 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)) 15:50:31 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)) 15:50:31 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)) 15:50:31 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)) 15:50:31 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)) 15:50:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:50:31 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 15:50:31 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 15:50:31 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 15:50:31 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 15:50:31 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 15:50:31 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 15:50:33 INFO - Downloading blessings-1.6.tar.gz 15:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:50:33 INFO - Installing collected packages: blessings 15:50:33 INFO - Running setup.py install for blessings 15:50:33 INFO - Successfully installed blessings 15:50:33 INFO - Cleaning up... 15:50:33 INFO - Return code: 0 15:50:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:50:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:33 INFO - Reading from file tmpfile_stdout 15:50:33 INFO - Current package versions: 15:50:33 INFO - argparse == 1.2.1 15:50:33 INFO - blessings == 1.6 15:50:33 INFO - blobuploader == 1.2.4 15:50:33 INFO - docopt == 0.6.1 15:50:33 INFO - functools32 == 3.2.3-2 15:50:33 INFO - jsonschema == 2.5.1 15:50:33 INFO - manifestparser == 1.1 15:50:33 INFO - mozInstall == 1.12 15:50:33 INFO - mozcrash == 0.17 15:50:33 INFO - mozdebug == 0.1 15:50:33 INFO - mozdevice == 0.48 15:50:33 INFO - mozfile == 1.2 15:50:33 INFO - mozhttpd == 0.7 15:50:33 INFO - mozinfo == 0.9 15:50:33 INFO - mozleak == 0.1 15:50:33 INFO - mozlog == 3.3 15:50:33 INFO - moznetwork == 0.27 15:50:33 INFO - mozprocess == 0.23 15:50:33 INFO - mozprofile == 0.28 15:50:33 INFO - mozrunner == 6.12 15:50:33 INFO - mozscreenshot == 0.1 15:50:33 INFO - mozsystemmonitor == 0.3 15:50:33 INFO - moztest == 0.7 15:50:33 INFO - mozversion == 1.4 15:50:33 INFO - psutil == 3.1.1 15:50:33 INFO - requests == 1.2.3 15:50:33 INFO - wsgiref == 0.1.2 15:50:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:33 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 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:33 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 15:50:33 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 15:50:33 INFO - Using env: {'DISPLAY': ':0', 15:50:33 INFO - 'HOME': '/home/cltbld', 15:50:33 INFO - 'LANG': 'en_US.UTF-8', 15:50:33 INFO - 'LANGUAGE': 'en_US:en', 15:50:33 INFO - 'LOGNAME': 'cltbld', 15:50:33 INFO - 'MAIL': '/var/mail/cltbld', 15:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:33 INFO - 'MOZ_NO_REMOTE': '1', 15:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:33 INFO - 'NO_EM_RESTART': '1', 15:50:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:33 INFO - 'PWD': '/builds/slave/test', 15:50:33 INFO - 'SHELL': '/bin/bash', 15:50:33 INFO - 'SHLVL': '1', 15:50:33 INFO - 'TERM': 'linux', 15:50:33 INFO - 'TMOUT': '86400', 15:50:33 INFO - 'USER': 'cltbld', 15:50:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:33 INFO - '_': '/tools/buildbot/bin/python'} 15:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:33 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)) 15:50:33 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)) 15:50:33 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)) 15:50:33 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)) 15:50:33 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)) 15:50:33 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)) 15:50:33 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)) 15:50:33 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)) 15:50:33 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)) 15:50:33 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)) 15:50:33 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)) 15:50:33 INFO - Cleaning up... 15:50:33 INFO - Return code: 0 15:50:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:33 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 0x1bd9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', '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 15:50:33 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 15:50:33 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 15:50:33 INFO - Using env: {'DISPLAY': ':0', 15:50:33 INFO - 'HOME': '/home/cltbld', 15:50:33 INFO - 'LANG': 'en_US.UTF-8', 15:50:33 INFO - 'LANGUAGE': 'en_US:en', 15:50:33 INFO - 'LOGNAME': 'cltbld', 15:50:33 INFO - 'MAIL': '/var/mail/cltbld', 15:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:33 INFO - 'MOZ_NO_REMOTE': '1', 15:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:33 INFO - 'NO_EM_RESTART': '1', 15:50:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:33 INFO - 'PWD': '/builds/slave/test', 15:50:33 INFO - 'SHELL': '/bin/bash', 15:50:33 INFO - 'SHLVL': '1', 15:50:33 INFO - 'TERM': 'linux', 15:50:33 INFO - 'TMOUT': '86400', 15:50:33 INFO - 'USER': 'cltbld', 15:50:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:33 INFO - '_': '/tools/buildbot/bin/python'} 15:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:50:33 INFO - Cleaning up... 15:50:33 INFO - Return code: 0 15:50:33 INFO - Running post-action listener: _resource_record_post_action 15:50:33 INFO - Running post-action listener: _start_resource_monitoring 15:50:33 INFO - Starting resource monitoring. 15:50:33 INFO - [mozharness: 2016-07-28 22:50:33.973689Z] Finished create-virtualenv step (success) 15:50:33 INFO - [mozharness: 2016-07-28 22:50:33.974166Z] Running install step. 15:50:33 INFO - Running pre-action listener: _resource_record_pre_action 15:50:33 INFO - Running main action method: install 15:50:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:34 INFO - Reading from file tmpfile_stdout 15:50:34 INFO - Detecting whether we're running mozinstall >=1.0... 15:50:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:50:34 INFO - Reading from file tmpfile_stdout 15:50:34 INFO - Output received: 15:50:34 INFO - Usage: mozinstall [options] installer 15:50:34 INFO - Options: 15:50:34 INFO - -h, --help show this help message and exit 15:50:34 INFO - -d DEST, --destination=DEST 15:50:34 INFO - Directory to install application into. [default: 15:50:34 INFO - "/builds/slave/test"] 15:50:34 INFO - --app=APP Application being installed. [default: firefox] 15:50:34 INFO - mkdir: /builds/slave/test/build/application 15:50:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:50:50 INFO - Reading from file tmpfile_stdout 15:50:50 INFO - Output received: 15:50:50 INFO - /builds/slave/test/build/application/firefox/firefox 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - [mozharness: 2016-07-28 22:50:50.680465Z] Finished install step (success) 15:50:50 INFO - [mozharness: 2016-07-28 22:50:50.680738Z] Running run-tests step. 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: run_tests 15:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:50:50 INFO - Python 2.7.3 15:50:50 INFO - Return code: 0 15:50:50 INFO - grabbing minidump binary from tooltool 15:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:50 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 0x1e983b0>, '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 0x1e992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:50:50 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 15:50:50 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 15:50:50 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 15:50:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:50:50 INFO - Return code: 0 15:50:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:50:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:50:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:50:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:50:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 15:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 15:50:50 INFO - Using env: {'DISPLAY': ':0', 15:50:50 INFO - 'HOME': '/home/cltbld', 15:50:50 INFO - 'LANG': 'en_US.UTF-8', 15:50:50 INFO - 'LANGUAGE': 'en_US:en', 15:50:50 INFO - 'LOGNAME': 'cltbld', 15:50:50 INFO - 'MAIL': '/var/mail/cltbld', 15:50:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:50 INFO - 'MOZ_NO_REMOTE': '1', 15:50:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:50 INFO - 'NO_EM_RESTART': '1', 15:50:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:50 INFO - 'PWD': '/builds/slave/test', 15:50:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:50 INFO - 'SHELL': '/bin/bash', 15:50:50 INFO - 'SHLVL': '1', 15:50:50 INFO - 'TERM': 'linux', 15:50:50 INFO - 'TMOUT': '86400', 15:50:50 INFO - 'USER': 'cltbld', 15:50:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813', 15:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:50 INFO - '_': '/tools/buildbot/bin/python'} 15:50:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 15:50:50 INFO - mozversion application_buildid: 20160728142528 15:50:50 INFO - mozversion application_changeset: 4c84eea22241b1ab95b64fee3596484ebdf78d24 15:50:50 INFO - mozversion application_display_name: Nightly 15:50:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:50:50 INFO - mozversion application_name: Firefox 15:50:50 INFO - mozversion application_remotingname: firefox 15:50:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:50:50 INFO - mozversion application_vendor: Mozilla 15:50:50 INFO - mozversion application_version: 50.0a1 15:50:50 INFO - mozversion platform_buildid: 20160728142528 15:50:50 INFO - mozversion platform_changeset: 4c84eea22241b1ab95b64fee3596484ebdf78d24 15:50:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:50:50 INFO - mozversion platform_version: 50.0a1 15:50:50 INFO - using testdate: 1469746250 15:50:50 INFO - actual date: 1469746250 15:50:50 INFO - starting webserver on 'localhost:45315' 15:50:50 INFO - SUITE-START | Running 2 tests 15:50:50 INFO - TEST-START | dromaeo_css 15:50:50 INFO - operating with platform_type : linux_ 15:50:50 INFO - Initialising browser for dromaeo_css test... 15:50:50 INFO - TEST-INFO | started process 1448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0SlOvA/profile http://localhost:45315/getInfo.html) 15:50:54 INFO - PROCESS | 1448 | JavaScript error: , line 0: uncaught exception: undefined 15:50:55 INFO - PROCESS | 1448 | __metrics Screen width/height:1600/1200 15:50:55 INFO - PROCESS | 1448 | colorDepth:24 15:50:55 INFO - PROCESS | 1448 | Browser inner width/height: 1024/697 15:50:55 INFO - PROCESS | 1448 | __metrics 15:50:55 INFO - PROCESS | 1448 | 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" 15:50:55 INFO - PROCESS | 1448 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:56 INFO - TEST-INFO | 1448: exit 0 15:50:56 INFO - Browser initialized. 15:50:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:50:56 INFO - TEST-INFO | started process 1529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0SlOvA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:08 INFO - PROCESS | 1529 | RSS: Main: 159338496 15:51:08 INFO - PROCESS | 1529 | 15:52:00 INFO - PROCESS | 1529 | 1469746320603 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] 15:54:12 INFO - PROCESS | 1529 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45315/tests/dromaeo/cssquery-ext.html) 15:54:13 INFO - PROCESS | 1529 | RSS: Main: 251281408 15:54:13 INFO - PROCESS | 1529 | 15:57:16 INFO - PROCESS | 1529 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-ext.html (next: http://localhost:45315/tests/dromaeo/cssquery-jquery.html) 15:57:16 INFO - PROCESS | 1529 | RSS: Main: 244830208 15:57:16 INFO - PROCESS | 1529 | 16:00:19 INFO - PROCESS | 1529 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45315/tests/dromaeo/cssquery-mootools.html) 16:00:19 INFO - PROCESS | 1529 | RSS: Main: 191090688 16:00:19 INFO - PROCESS | 1529 | 16:03:21 INFO - PROCESS | 1529 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45315/tests/dromaeo/cssquery-prototype.html) 16:03:22 INFO - PROCESS | 1529 | RSS: Main: 195145728 16:03:22 INFO - PROCESS | 1529 | 16:06:25 INFO - PROCESS | 1529 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45315/tests/dromaeo/cssquery-yui.html) 16:06:25 INFO - PROCESS | 1529 | RSS: Main: 191827968 16:06:25 INFO - PROCESS | 1529 | 16:09:28 INFO - PROCESS | 1529 | Cycle 1(1): loaded http://localhost:45315/tests/dromaeo/cssquery-yui.html (next: http://localhost:45315/tests/dromaeo/cssquery-dojo.html) 16:09:29 INFO - PROCESS | 1529 | RSS: Main: 280616960 16:09:29 INFO - PROCESS | 1529 | 16:09:29 INFO - PROCESS | 1529 | __start_tp_report 16:09:29 INFO - PROCESS | 1529 | _x_x_mozilla_page_load 16:09:29 INFO - PROCESS | 1529 | _x_x_mozilla_page_load_details 16:09:29 INFO - PROCESS | 1529 | |i|pagename|runs| 16:09:29 INFO - PROCESS | 1529 | |0;dojo.html;2629.73702629737;2637.5911733681264;2662.7071022187556;2670.0387860370274;2674.478476697044;4664.76676166192;4751.02603966187;4777.832775852846;4851.514848515147;4854.368932038835;4765.118453086173;4803.903921921568;4808.783604737787;4827.420709514854;4862.61099112071;4340.696151269412;4351.978240108795;4389.990302230489;4467.374567560544;4535.614472769818;4488.596026357627;4520.819167233323;4522.366868638377;4544.727316361029;4549;4326.9567304326865;4330.545292744248;4396.318570621559;4411.801468933906;4430.6898517103655;4341.435613370273;4372.060007098457;4374.562543745632;4446.888827779331;4480.84317048905;4407.316865885793;4412.271975124133;4419.138268037734;4425.712328698624;4435.800388982503;4707.764611769432;4730.716157030589;4797.544233297831;4889.046635906;4893.339399181101;5129.563987061104;5171.327727395452;5206.921896171522;5218.112920803473;5224.451432599561;5207.3490813648295;5215.817446389358;5244.737763111867;5260.684358938476;5268.1834315681135;4694.929576056362;4780.020095880405;4812.1578723723205;4893;4896.510348965075;5304;5328.813491527778;5365.248865158881;5379.596530260168;5385.246065550826;5101.923471147936;5106.029854327666;5142.151544995108;5154.974225128925;5159.1229490986625;5008.549230569266;5083.593312534988;5142.023015627019;5190.169572868398;5237.423883372826;5107.489251074863;5108.872278193001;5116.437191908887;5145.665531740499;5163.7676304566385;5086.9745651271505;5099.821506247264;5102.897942041212;5116.984509808767;5162.09663308927;4232.703710740218;4303.182395344875;4321.373400856858;4383.802728877208;4435.82256709728;3799.164183879542;3834.616538346143;3863.9227215456094;3882.301185786529;3912.4718163047623;4418.779061046999;4420.071784925138;4426.9778651106535;4434.623057040123;4477.082198149372;5003.2995380646735;5063.088644044107;5179.741012949337;5204.687718736888;5238.71187084714;4347.673924455678;4392.231359512072;4408.713433626868;4423.579759922803;4434.977825110854;4626.074785043005;4633.49031606523;4635.281531362644;4646.001109761418;4689;4813.109574728686;4862.149123903374;4869.415670119608;4877.219644856806;4912.729799861042;5070.4929507049;5085;5093.363329583802;5107.668001579886;5208.5051920069045;4823.975880120577;4824.324594556835;4829.830955916526;4837.331974644485;4879.56083952446;5122.103631864484;5126.846194614168;5130.179171332569;5130.358705161855;5178.067947769287;4959.20652695567;5090.643654944119;5117.692938423706;5147.871303217449;5211.895762084813;5031.6729412588065;5048.293238946624;5048.671836330626;5053.924191137063;5097.2608971698155;5012.47369026247;5028.2960385546785;5031.270465782514;5031.7484125792835;5036.974815125901;4810.374651295309;4905.975470122627;4952.504749525018;4966.6771659842;5025.422076461254;5054.317667114892;5060.645754797129;5066.544011039025;5072.51811077947;5127.4103478099005;4908.852734417973;4923.630727695366;4926.827561035347;4926.8768280793265;4972.900541989067 16:09:29 INFO - PROCESS | 1529 | |1;ext.html;568.7696482924415;579.0185635348084;583.5098517245513;595.6664268009912;599.3886236039243;27231.45537089257;38802;40310;40378.79810600947;44382.77808610952;41124.38313425301;41466.378004329956;41608.37587436191;41625;41631.375529367084;7405.111386633612;7615.048118985127;7740.419468539854;7757.650905709256;7759.146493885668;9647.421154730704;9899.20806335495;9900.306978511471;10200.846987295197;10210.978902109766;9818.607255709763;9893.901060989407;9898.703038908845;9906.65326713565;9908.306418550668;9894.505274736235;9907;9922;9953.452560109155;9958.850617240747;9804.215662747034;9857.211423086208;9869.753256168582;9870.407775533491;9871.259655525864;38924.61075389238;39121.60878391208;39163.60836391628;39176;39247.41128883069;3082.214035420953;3246.3020450603;3670.632936706308;3724.2179142380132;3766.6986641068647;27298;29328;29615.259618509495;30188.698113018807;30416;3368.1747971746836;3414.5561077059824;3487.442009278503;3490.7556471047037;3502.842372093262;260790;263676;263682;263785.68107159535;264639.7680115987;54883.72558137264;55315.72342138264;55317.723411382685;55349.169762453595;55372;32728;33764.83117584397;34009.149771255914;35688.64311356905;57165.42834571601;15797.289121989537;15946.36214551405;15948.76076858848;15955.680886382208;15958.441454549267;11170.609028683957;11866.110041746904;12111.576094836639;12148.392580371123;12219.083568732382;18105;18163.18265678048;18236.726449103273;18272.908635457003;18302.633947320977;6926.545425460609;7034.366906978396;7077.5753454792875;7134.751418501742;7206.531575447579;869.8869147010848;870.1168314161132;870.4037734152126;894.7449976756593;909.60432211988;28217.43565128727;28854.855725721238;28947.42105157885;29243.268918277212;29435.705642943725;928.7956649537091;965.5944503308627;1009.7728011197422;1040.8074506216374;1081.113486940701;14899.957003009686;14956.326965286587;15365.308561114776;15482.767758483631;15548.611284717972;384620;389312;389676;391265;391282;49866;50262;50559.49440505621;50638.24042639363;50725.74637126791;1076.219740687995;1110.5502271580024;1147.925384849982;1156.670348950545;1213.6055781870928;27046.45907081808;29621.407571848875;29763.107106786832;30560.84719576388;30602;43450;43904.34143487786;43910.34134488049;43985;43995.34006989834;318006;318449;320032;320176;320475;25214.621780672936;25937;26111.08611198599;26149.084782032536;27247.318817029733;41838.1632367357;42061.36907946444;42198.57801422069;42296.1540769189;43253.56746432495;35588.466173006906;35927.10182245465;36154.63845361618;36712.26575468529;36914.44628330523;36900.023413720526;37259.627403725615;37503.06242343963;37591.43612845755;38391.42412863753;35835.82082089573;36554.634453655126;36678.26643467169;36954;36991.81504092462;31525.842370788;33116.69231497125;33828.83085584556;33832.66167338393;33835;25199.748002520475;25438.364040899127;25600.487990240465;25812.61281080823;25825.6126158104 16:09:29 INFO - PROCESS | 1529 | |2;jquery.html;348.1071052749695;361.96199399063113;367.4836854219821;369.89088218975405;379.9962000379997;13026.023048271381;15994.280257388416;16252.837471625295;17306.653866922654;17525.912370438164;16291.83708162921;16574.254158562864;16823;16897.662046759087;17549.385771498;5048.066107770056;5074.670146440479;5161.406438259592;5209.7134657593815;5219.5041471060185;3672.889813305605;5143.254228136918;5227.712475813829;5728.885422291552;6049.395060493959;6074.088886667013;6074.5747797654185;6091.664958427285;6106.786262480814;6113;5933.465988061073;5979.192808970777;6038.2150320458495;6063.423974722395;6068.817935461943;5163.896722065575;5307.071262529081;5316.308879845634;5320.547753440962;5320.600954928396;20788.168473261052;20885.164593416244;21106.472338191514;21115.577688446298;21129.47176320589;1873.100911562444;1893.4698284480367;1957.530192753743;1960.8529360297891;1998.540335722792;12756.425960831784;13319.200847949154;13359.1316564423;13715.177089374669;13880.58358249244;1635.386729976259;1725.6289897672061;1754.4648882090958;1791.2924394863956;1794.9282028718835;67563;68612.6569367155;69507.3049269511;70754.29245707528;72197.27802721958;8385.287250583646;8961.283097352196;8995.820083598292;9447.52762361893;9685.6610018649;11665.941670291595;11731.120165987584;11806.88193118075;11820.586279480349;11856.822147667792;5677.602567820296;5801.564882633819;5806;6356.713947872357;7417.443691723142;7322.487425880137;7379.631018449056;7403.51877127985;7534.020577325023;7639.69441222356;3724.571674257441;3725.2549490102087;3764.924701506009;3814.237152569497;3823.5029446172375;1814.6280012597385;1838.9816101839078;1840.1351364858494;1850.9629807404046;1858.50749551369;762.9923700762921;845.9534725590029;883.4610887358706;887.1970866365949;924.861270809384;16578.66842663164;16776.66446671084;17501.299948002194;17723.46829595114;17745.7338139928;773.6325245508339;827.0778082438038;828.5185868324407;889.3996552327153;899.581694512055;9423.38747981379;9445.669401570913;9909.20726341891;9960.701178964642;10069.496525173712;375529;377304;377919;378785;380405;76360;77115.22884771193;77640.447191057;79483;81019;887.3921363865772;898.3038145437338;900.1808354397598;901.5041727050096;901.9549022548846;15331.693366132838;15603;15870;16140.112293823953;16336.346546138497;37129.81435092807;37786;38122.237555249296;39837.80081099576;40480;54410.18384724153;55934.16098758603;56055.71972140113;56805.431945680015;56839.71580142073;7642.7325043623205;7722.343600793771;7848.254415830487;7955.2840244378285;8129.3090087343235;12076;12163.817542737042;12205;12451.315177664954;12653.493860245855;4906.803727850989;7215.8556828864175;7334.4132469403385;10407;11124.777504450027;10659.25385223058;10677.786444270916;10681.19891008193;10929.726756831144;11039.724006899893;10664.946675266574;10737.89262107369;10925.726856828644;11064;11073.065637606202;6691;7050.118735158106;7152.570845749272;7941.642626081955;8014.0383154019555;10390.948045259725;10463.843042354523;10593.947030264799;10659.200559957879;10917.56329746833 16:09:29 INFO - PROCESS | 1529 | |3;mootools.html;1260.50210166984;1318.06417443615;1374.7181827725315;1433.2403825972233;1671.4317132175058;6694.966525167373;7483.10202775667;7726.536407815528;7743.18696536864;7990.92009079909;7839.451238413313;7860.331871790904;7898.328642065431;7901.960490197555;7907.8418431631335;2159.6436587962967;2180.6183917814396;2183.7597864235;2184.421128400975;2201.8348623853194;2148.4414052346347;2180.3785921012513;2213.9557208855813;2218.6117429449864;2220.8667479951173;2134.8719076855436;2144.5710857828417;2160.2547121243147;2162.7296587926508;2196.769339219383;2141.100737690166;2142.7964343387353;2144.345974477784;2144.5710857828417;2144.6354119799516;2094.832413406939;2133.7119488868957;2136.060133541237;2137.5831712815852;2137.7648458669532;7446.180920098785;7861.017372828396;7878.369730421553;7917.089534703525;7919.208079192093;4585.564371384713;4704.929426058612;4755.262934245163;4780.282957556359;4786.497417771154;2794.538901081319;2930.3846192299643;3019.21500409895;3020.4714175019285;3030.030390275113;880.2517859819167;881.8941726992801;896.9775755606097;900.4372267332917;905.4069584422214;10551;10674.146068314594;10714.9464252679;10740.033396994308;10747.51636176366;4099.877003689894;4235.661147108224;4377.212101821703;4435.645148388121;4440.777961101932;9270.304727145356;9274.026227246177;9283.72148835536;9290.860637090449;9295.07049295065;4612.95387046132;4619.3071039343695;4625.606823419979;4681.157391669532;4697.95302046982;3682.4844521766972;3746.6253374662315;3900.8244628991765;4211.0946146578635;4213.073123912734;3636.927261454809;3740.532433445819;3831.5210598675167;3844.826982785781;3847.2690188864026;1198.4427241332821;1236.4744983382027;1236.7959286717771;1243.210561293567;1258.5154715434442;831.4927893984665;837.4891316297054;840.8528507511284;842.2083241752733;878.7188099808128;5265.1049321614655;5266.183741520071;5295.470452954673;5379.35447746273;5494.945050549443;408.6403964511211;419.24954331745835;426.44775016353896;427.7177063138376;430.7071191589686;3637.418013117888;3762.2851658185405;3828.5214348206473;3844.1927195288745;3844.9038774030873;9361.719148425558;9756.170725488271;9787.46168960714;9794.902050979541;9804.852927206097;9686.806263874683;9707.6116955321;9727;9727.173190278905;9727.951360243154;7363.079615048119;7420.183779784219;7420.5176663516695;7427.145878223965;7448.813779655552;5278.8944221116135;5331.5201631853315;5334.306540149756;5339.65055375649;5447.564194864322;8719.12808719123;8793.516356600448;8815.735527934172;8925.107489251022;9004;8830.514321712111;8904.910950890408;8980.685676001309;8990.775230619287;9099.727008189764;6601.042848786995;6682.966585167043;6686.197656281277;6692.966535167293;6694.0628312037325;7292.0520332356455;7395.371393431618;7400.259974002557;7450.925490745023;7490.5131166474;6808.455323574201;6829.897551536632;6845.897311540431;6851.657417129024;6907.378335949788;6644.402003819486;6656.30108838565;6687.264400915798;6700.83247918806;6714.328567143247;5828.6502809831545;5918.496927761016;5923.141144533933;5927.110933360031;5932.5550583705535;4594.88512787183;4670;4777.976110119427;4822.228443449031;4848.418189817245;4636.188666983332;4673.205555055581;4720.858374248778;4727.645426592951;4877.073356062337 16:09:29 INFO - PROCESS | 1529 | |4;prototype.html;288.7444611518805;294.5949319685433;301.7209081599521;303.3977554554211;304.3092180749697;4862.756862156892;4916.483769204236;4926.876828079296;4934.703917764928;4943.579795717359;4625.884352891171;4722.1972264715;4762.523747625244;4830.541098595637;4875.536824001723;3848.230353929225;3855.132595166079;3855.807209639521;3871.412720784479;3880.0881792778746;3846.576876543578;3847.2305538892333;3866.2074274773745;3871.7870517121546;3873.283442563121;3678.7792732436005;3707.1288247261873;3791.924161516768;3822.7706337619693;3827.7559793067226;3816.713746468998;3822.3502004659276;3849.7690138591634;3854.1906199698096;3854.383298672199;3358.2947581008016;3365.7980521168806;3370.865165393381;3371.0729549373873;3408.3183363327184;4638.6084174747775;4708.764561771898;4744.14605371033;4748.548887855648;4796.304535842318;4334.154839806208;4339.47926248849;4345.913081738379;4365;4400.537943515917;5060.165072762989;5067.6452648314635;5112.923306150411;5119.6160287978555;5129.589632829402;3680.907977300562;3688.944665830015;3694.9284707434813;3717.4052151655605;3736.1132628022674;5213.244079608436;5263.894722105575;5271.367435907678;5297.682139071668;5299.364076310829;3762.9435558466644;3777.6033516480925;3786.8295926683363;3787.579657628389;3795.9750867266234;3842.212346468967;3846.9230615387537;3850.403187505941;3864.686006757716;3895.590962948906;4236.76697781625;4308.6983911126545;4370.409994650745;4398.890027749268;4403.229434848889;5043.823466178739;5059.988002399461;5065.848024559269;5069.594432445396;5128.8717782055;1264.8039553869164;1319.4788058716754;1331.6138319887318;1333.9599812005656;1344.836716240445;887.3078998381272;917.821024900138;929.5909799688116;931.7391130483476;934.5934518484481;4482.058767658763;4484.520108364232;4490.775461226991;4492.124035813051;4495.707778994355;5252.317198764213;5262.71055091966;5263.184206448007;5271.499207575274;5278.2346559749385;4339.088791353851;4450.35469856869;4467.486239082482;4474.507804141542;4482.148391805612;2746.6703995520666;2755.435135797157;2759.9310017249327;2763.6269103671148;2777.222377734238;4881.731504767272;4902.338184345068;4907.460179380265;4912.6561140719805;4915.16442204826;5106.642535022513;5244.715044814045;5247.921281180786;5255.290535777697;5283.128283833202;4845.9757701211265;4906.2640603909695;4919.729414882144;4925.999999999928;4936.308916751729;5131.435542090292;5199.620246839585;5217.921731173959;5268.710220937885;5280.049591073644;4945.77744001528;5171.198464238049;5177.119889618699;5189.818356357509;5211.76547055391;4994.225894986283;4996.15065438869;4996.900061998813;5007.273945277987;5017.218887294957;3712.573054098705;3736.551613806361;3740.925181496409;3746;3762.3792074308526;5162.387044824229;5282.683039017671;5296.3379577552805;5327.413984461784;5360.892782144258;5118.360204974379;5145.639805213599;5149.382074151126;5153.175491921274;5193.818216362409;5020.322256495327;5141.126008578476;5141.742912854417;5158.38099428071;5159.716215608028;4829.13075646387;5028.094942910311;5038.7984480621835;5054.418741844588;5056.216286475602;5001.424836143745;5042.9243561345875;5168.922466162935;5189.922151167811;5196.636235463481;4993.925091123563;5050.949490505048;5052.621053420935;5060.2156665716875;5063.696178229171 16:09:29 INFO - PROCESS | 1529 | |5;yui.html;567.798431556797;578.2396149063983;581.3575998521634;583.6517644241802;590.7489317040257;11045.282056666321;12092.818607720868;12106.031517478603;12176.81734773979;12290.754184916297;11473.368964706939;11667.591634292801;11763.35301558416;11778.175527713063;11792.233504822181;758.9582572958485;776.7825008997462;776.9184235655259;777.0985656638301;777.4480119115435;632.8038308124474;751.1361933776174;780.3679019993795;782.4092809928496;789.6801795272924;823.6993497373445;825.8843761873343;825.8926339575877;826.5949684654506;826.7933016745814;821.40858581821;821.4988856797349;821.6056292979373;821.8109834738013;822.839546288474;483.8838678717083;574.7815829984579;590.0676930449879;592.884387544429;596.1415561591294;12053.758924821455;12092.576759813364;12122.212056216318;12147.453364598614;12168.756624867454;11297.49161287744;11354.48904799286;11357.375344356056;11506.424678766029;12034.939825300906;11592.826107608393;11647.76704465906;11657.883421165765;11789.351585662786;11920.22518536301;4071.653909417703;4097.364908439196;4146.108586653853;4181.0592616661315;4267.530571637118;51043.46869593881;53124.999999999614;53871.730641346934;60835.695821521054;62140.06789898155;9717.271204659679;9816.214702823758;9836;9889.10998010168;9897.455639939872;15777.132257725936;15787.210639467981;15798.526044218692;15809.051456912392;15820.208989550476;6780.32196780318;6841.452683785285;6841.863162736718;6862.553933994274;7079.079719636415;3625.9456108158397;3672.1737609037755;3695.1685870678884;3717.5353080864893;3789.9242015159543;2765.3916138449913;2837.3474100956482;2856.4858325501195;2856.6429196350455;2861.527847905114;514.7966553211461;517.4153206876206;526.7866514061811;532.2761044978826;539.1965970703702;501.9247112933089;584.5440556366042;598.1058317814808;600.3696119074954;603.5594016368076;7534.397248220129;7547.622618869144;7596.696132154652;7735.381169506539;7773.222677732295;476.7179649483712;591.9230500034968;594.690760804388;595.9970200149058;614.7233744814762;3496.6328535503912;3554.644535546425;3632.9818350908076;3714.201446688975;3730.0363723450087;56895.43104568984;58377.416225838046;60361.02238018759;111891;112048.43975780232;89481;91079;91804.54097729469;93776;94277;50353.49646503561;67313.66343168252;82706.58646706727;82772.58613707013;83021.58489207516;6733.764318249034;6819.795406137824;6856.314368563303;6870.656467176721;7103.360697537039;46387.76806115948;47388;47492;48144;49355.50644493509;44615;67958;68864.65567672129;69779.95330070154;73401.26598733944;8959.596818143069;9138.406003609743;9188.632454702005;9492.810143797224;9510.524473776422;10165.745856353355;10176.847347289648;10222.897771022195;10294.919033501674;10366.792664146524;9712.368696034735;9960.601575937171;10050.69847904564;10078.94960525222;10193.847092293474;9278.628854846;9490.667826626035;9541.952290238782;9632.373895696757;9770.31607787448;9546.140847323773;9572.425654460754;9744.75638109053;10111.7472063199;10134.037266459674;8094.31198348147;8140.389470789596;8190.713325033834;8426.4944103354;8429.367797415342;8043.235892590194;8217.178282171735;8453.535055572003;8649.61076751535;8785.428947118417 16:09:29 INFO - PROCESS | 1529 | __end_tp_report 16:09:29 INFO - PROCESS | 1529 | __start_cc_report 16:09:29 INFO - PROCESS | 1529 | _x_x_mozilla_cycle_collect,982 16:09:29 INFO - PROCESS | 1529 | __end_cc_report 16:09:29 INFO - PROCESS | 1529 | __startTimestamp1469747369045__endTimestamp 16:09:29 INFO - PROCESS | 1529 | 16:09:29 INFO - PROCESS | 1529 | ------- Summary: start ------- 16:09:29 INFO - PROCESS | 1529 | Number of tests: 6 16:09:29 INFO - PROCESS | 1529 | 16:09:29 INFO - PROCESS | 1529 | [#0] dojo.html Cycles:165 Average:4763.71 Median:4893.00 stddev:508.58 (10.4%) stddev-sans-first:481.80 16:09:29 INFO - PROCESS | 1529 | Values: 2629.7 2637.6 2662.7 2670.0 2674.5 4664.8 4751.0 4777.8 4851.5 4854.4 4765.1 4803.9 4808.8 4827.4 4862.6 4340.7 4352.0 4390.0 4467.4 4535.6 4488.6 4520.8 4522.4 4544.7 4549.0 4327.0 4330.5 4396.3 4411.8 4430.7 4341.4 4372.1 4374.6 4446.9 4480.8 4407.3 4412.3 4419.1 4425.7 4435.8 4707.8 4730.7 4797.5 4889.0 4893.3 5129.6 5171.3 5206.9 5218.1 5224.5 5207.3 5215.8 5244.7 5260.7 5268.2 4694.9 4780.0 4812.2 4893.0 4896.5 5304.0 5328.8 5365.2 5379.6 5385.2 5101.9 5106.0 5142.2 5155.0 5159.1 5008.5 5083.6 5142.0 5190.2 5237.4 5107.5 5108.9 5116.4 5145.7 5163.8 5087.0 5099.8 5102.9 5117.0 5162.1 4232.7 4303.2 4321.4 4383.8 4435.8 3799.2 3834.6 3863.9 3882.3 3912.5 4418.8 4420.1 4427.0 4434.6 4477.1 5003.3 5063.1 5179.7 5204.7 5238.7 4347.7 4392.2 4408.7 4423.6 4435.0 4626.1 4633.5 4635.3 4646.0 4689.0 4813.1 4862.1 4869.4 4877.2 4912.7 5070.5 5085.0 5093.4 5107.7 5208.5 4824.0 4824.3 4829.8 4837.3 4879.6 5122.1 5126.8 5130.2 5130.4 5178.1 4959.2 5090.6 5117.7 5147.9 5211.9 5031.7 5048.3 5048.7 5053.9 5097.3 5012.5 5028.3 5031.3 5031.7 5037.0 4810.4 4906.0 4952.5 4966.7 5025.4 5054.3 5060.6 5066.5 5072.5 5127.4 4908.9 4923.6 4926.8 4926.9 4972.9 16:09:29 INFO - PROCESS | 1529 | 16:09:29 INFO - PROCESS | 1529 | [#1] ext.html Cycles:180 Average:48075.01 Median:36907.23 stddev:86179.20 (233.5%) stddev-sans-first:86347.14 16:09:29 INFO - PROCESS | 1529 | Values: 568.8 579.0 583.5 595.7 599.4 27231.5 38802.0 40310.0 40378.8 44382.8 41124.4 41466.4 41608.4 41625.0 41631.4 7405.1 7615.0 7740.4 7757.7 7759.1 9647.4 9899.2 9900.3 10200.8 10211.0 9818.6 9893.9 9898.7 9906.7 9908.3 9894.5 9907.0 9922.0 9953.5 9958.9 9804.2 9857.2 9869.8 9870.4 9871.3 38924.6 39121.6 39163.6 39176.0 39247.4 3082.2 3246.3 3670.6 3724.2 3766.7 27298.0 29328.0 29615.3 30188.7 30416.0 3368.2 3414.6 3487.4 3490.8 3502.8 260790.0 263676.0 263682.0 263785.7 264639.8 54883.7 55315.7 55317.7 55349.2 55372.0 32728.0 33764.8 34009.1 35688.6 57165.4 15797.3 15946.4 15948.8 15955.7 15958.4 11170.6 11866.1 12111.6 12148.4 12219.1 18105.0 18163.2 18236.7 18272.9 18302.6 6926.5 7034.4 7077.6 7134.8 7206.5 869.9 870.1 870.4 894.7 909.6 28217.4 28854.9 28947.4 29243.3 29435.7 928.8 965.6 1009.8 1040.8 1081.1 14900.0 14956.3 15365.3 15482.8 15548.6 384620.0 389312.0 389676.0 391265.0 391282.0 49866.0 50262.0 50559.5 50638.2 50725.7 1076.2 1110.6 1147.9 1156.7 1213.6 27046.5 29621.4 29763.1 30560.8 30602.0 43450.0 43904.3 43910.3 43985.0 43995.3 318006.0 318449.0 320032.0 320176.0 320475.0 25214.6 25937.0 26111.1 26149.1 27247.3 41838.2 42061.4 42198.6 42296.2 43253.6 35588.5 35927.1 36154.6 36712.3 36914.4 36900.0 37259.6 37503.1 37591.4 38391.4 35835.8 36554.6 36678.3 36954.0 36991.8 31525.8 33116.7 33828.8 33832.7 33835.0 25199.7 25438.4 25600.5 25812.6 25825.6 16:09:29 INFO - PROCESS | 1529 | 16:09:29 INFO - PROCESS | 1529 | [#2] jquery.html Cycles:180 Average:24260.86 Median:3818.87 stddev:62606.46 (1639.4%) stddev-sans-first:62756.34 16:09:29 INFO - PROCESS | 1529 | Values: 348.1 362.0 367.5 369.9 380.0 13026.0 15994.3 16252.8 17306.7 17525.9 16291.8 16574.3 16823.0 16897.7 17549.4 5048.1 5074.7 5161.4 5209.7 5219.5 3672.9 5143.3 5227.7 5728.9 6049.4 6074.1 6074.6 6091.7 6106.8 6113.0 5933.5 5979.2 6038.2 6063.4 6068.8 5163.9 5307.1 5316.3 5320.5 5320.6 20788.2 20885.2 21106.5 21115.6 21129.5 1873.1 1893.5 1957.5 1960.9 1998.5 12756.4 13319.2 13359.1 13715.2 13880.6 1635.4 1725.6 1754.5 1791.3 1794.9 67563.0 68612.7 69507.3 70754.3 72197.3 8385.3 8961.3 8995.8 9447.5 9685.7 11665.9 11731.1 11806.9 11820.6 11856.8 5677.6 5801.6 5806.0 6356.7 7417.4 7322.5 7379.6 7403.5 7534.0 7639.7 3724.6 3725.3 3764.9 3814.2 3823.5 1814.6 1839.0 1840.1 1851.0 1858.5 763.0 846.0 883.5 887.2 924.9 16578.7 16776.7 17501.3 17723.5 17745.7 773.6 827.1 828.5 889.4 899.6 9423.4 9445.7 9909.2 9960.7 10069.5 375529.0 377304.0 377919.0 378785.0 380405.0 76360.0 77115.2 77640.4 79483.0 81019.0 887.4 898.3 900.2 901.5 902.0 15331.7 15603.0 15870.0 16140.1 16336.3 37129.8 37786.0 38122.2 39837.8 40480.0 54410.2 55934.2 56055.7 56805.4 56839.7 7642.7 7722.3 7848.3 7955.3 8129.3 12076.0 12163.8 12205.0 12451.3 12653.5 4906.8 7215.9 7334.4 10407.0 11124.8 10659.3 10677.8 10681.2 10929.7 11039.7 10664.9 10737.9 10925.7 11064.0 11073.1 6691.0 7050.1 7152.6 7941.6 8014.0 10390.9 10463.8 10593.9 10659.2 10917.6 16:09:29 INFO - PROCESS | 1529 | 16:09:29 INFO - PROCESS | 1529 | [#3] mootools.html Cycles:180 Average:5146.53 Median:5265.64 stddev:2899.22 (55.1%) stddev-sans-first:2892.64 16:09:29 INFO - PROCESS | 1529 | Values: 1260.5 1318.1 1374.7 1433.2 1671.4 6695.0 7483.1 7726.5 7743.2 7990.9 7839.5 7860.3 7898.3 7902.0 7907.8 2159.6 2180.6 2183.8 2184.4 2201.8 2148.4 2180.4 2214.0 2218.6 2220.9 2134.9 2144.6 2160.3 2162.7 2196.8 2141.1 2142.8 2144.3 2144.6 2144.6 2094.8 2133.7 2136.1 2137.6 2137.8 7446.2 7861.0 7878.4 7917.1 7919.2 4585.6 4704.9 4755.3 4780.3 4786.5 2794.5 2930.4 3019.2 3020.5 3030.0 880.3 881.9 897.0 900.4 905.4 10551.0 10674.1 10714.9 10740.0 10747.5 4099.9 4235.7 4377.2 4435.6 4440.8 9270.3 9274.0 9283.7 9290.9 9295.1 4613.0 4619.3 4625.6 4681.2 4698.0 3682.5 3746.6 3900.8 4211.1 4213.1 3636.9 3740.5 3831.5 3844.8 3847.3 1198.4 1236.5 1236.8 1243.2 1258.5 831.5 837.5 840.9 842.2 878.7 5265.1 5266.2 5295.5 5379.4 5494.9 408.6 419.2 426.4 427.7 430.7 3637.4 3762.3 3828.5 3844.2 3844.9 9361.7 9756.2 9787.5 9794.9 9804.9 9686.8 9707.6 9727.0 9727.2 9728.0 7363.1 7420.2 7420.5 7427.1 7448.8 5278.9 5331.5 5334.3 5339.7 5447.6 8719.1 8793.5 8815.7 8925.1 9004.0 8830.5 8904.9 8980.7 8990.8 9099.7 6601.0 6683.0 6686.2 6693.0 6694.1 7292.1 7395.4 7400.3 7450.9 7490.5 6808.5 6829.9 6845.9 6851.7 6907.4 6644.4 6656.3 6687.3 6700.8 6714.3 5828.7 5918.5 5923.1 5927.1 5932.6 4594.9 4670.0 4778.0 4822.2 4848.4 4636.2 4673.2 4720.9 4727.6 4877.1 16:09:29 INFO - PROCESS | 1529 | 16:09:29 INFO - PROCESS | 1529 | [#4] prototype.html Cycles:180 Average:4248.90 Median:4854.37 stddev:1219.17 (25.1%) stddev-sans-first:1185.81 16:09:29 INFO - PROCESS | 1529 | Values: 288.7 294.6 301.7 303.4 304.3 4862.8 4916.5 4926.9 4934.7 4943.6 4625.9 4722.2 4762.5 4830.5 4875.5 3848.2 3855.1 3855.8 3871.4 3880.1 3846.6 3847.2 3866.2 3871.8 3873.3 3678.8 3707.1 3791.9 3822.8 3827.8 3816.7 3822.4 3849.8 3854.2 3854.4 3358.3 3365.8 3370.9 3371.1 3408.3 4638.6 4708.8 4744.1 4748.5 4796.3 4334.2 4339.5 4345.9 4365.0 4400.5 5060.2 5067.6 5112.9 5119.6 5129.6 3680.9 3688.9 3694.9 3717.4 3736.1 5213.2 5263.9 5271.4 5297.7 5299.4 3762.9 3777.6 3786.8 3787.6 3796.0 3842.2 3846.9 3850.4 3864.7 3895.6 4236.8 4308.7 4370.4 4398.9 4403.2 5043.8 5060.0 5065.8 5069.6 5128.9 1264.8 1319.5 1331.6 1334.0 1344.8 887.3 917.8 929.6 931.7 934.6 4482.1 4484.5 4490.8 4492.1 4495.7 5252.3 5262.7 5263.2 5271.5 5278.2 4339.1 4450.4 4467.5 4474.5 4482.1 2746.7 2755.4 2759.9 2763.6 2777.2 4881.7 4902.3 4907.5 4912.7 4915.2 5106.6 5244.7 5247.9 5255.3 5283.1 4846.0 4906.3 4919.7 4926.0 4936.3 5131.4 5199.6 5217.9 5268.7 5280.0 4945.8 5171.2 5177.1 5189.8 5211.8 4994.2 4996.2 4996.9 5007.3 5017.2 3712.6 3736.6 3740.9 3746.0 3762.4 5162.4 5282.7 5296.3 5327.4 5360.9 5118.4 5145.6 5149.4 5153.2 5193.8 5020.3 5141.1 5141.7 5158.4 5159.7 4829.1 5028.1 5038.8 5054.4 5056.2 5001.4 5042.9 5168.9 5189.9 5196.6 4993.9 5050.9 5052.6 5060.2 5063.7 16:09:29 INFO - PROCESS | 1529 | 16:09:29 INFO - PROCESS | 1529 | [#5] yui.html Cycles:180 Average:16832.93 Median:592.40 stddev:25089.64 (4235.2%) stddev-sans-first:25130.30 16:09:29 INFO - PROCESS | 1529 | Values: 567.8 578.2 581.4 583.7 590.7 11045.3 12092.8 12106.0 12176.8 12290.8 11473.4 11667.6 11763.4 11778.2 11792.2 759.0 776.8 776.9 777.1 777.4 632.8 751.1 780.4 782.4 789.7 823.7 825.9 825.9 826.6 826.8 821.4 821.5 821.6 821.8 822.8 483.9 574.8 590.1 592.9 596.1 12053.8 12092.6 12122.2 12147.5 12168.8 11297.5 11354.5 11357.4 11506.4 12034.9 11592.8 11647.8 11657.9 11789.4 11920.2 4071.7 4097.4 4146.1 4181.1 4267.5 51043.5 53125.0 53871.7 60835.7 62140.1 9717.3 9816.2 9836.0 9889.1 9897.5 15777.1 15787.2 15798.5 15809.1 15820.2 6780.3 6841.5 6841.9 6862.6 7079.1 3625.9 3672.2 3695.2 3717.5 3789.9 2765.4 2837.3 2856.5 2856.6 2861.5 514.8 517.4 526.8 532.3 539.2 501.9 584.5 598.1 600.4 603.6 7534.4 7547.6 7596.7 7735.4 7773.2 476.7 591.9 594.7 596.0 614.7 3496.6 3554.6 3633.0 3714.2 3730.0 56895.4 58377.4 60361.0 111891.0 112048.4 89481.0 91079.0 91804.5 93776.0 94277.0 50353.5 67313.7 82706.6 82772.6 83021.6 6733.8 6819.8 6856.3 6870.7 7103.4 46387.8 47388.0 47492.0 48144.0 49355.5 44615.0 67958.0 68864.7 69780.0 73401.3 8959.6 9138.4 9188.6 9492.8 9510.5 10165.7 10176.8 10222.9 10294.9 10366.8 9712.4 9960.6 10050.7 10078.9 10193.8 9278.6 9490.7 9542.0 9632.4 9770.3 9546.1 9572.4 9744.8 10111.7 10134.0 8094.3 8140.4 8190.7 8426.5 8429.4 8043.2 8217.2 8453.5 8649.6 8785.4 16:09:29 INFO - PROCESS | 1529 | -------- Summary: end -------- 16:09:29 INFO - PROCESS | 1529 | 16:09:29 INFO - TEST-INFO | 1529: exit 0 16:09:29 INFO - TEST-OK | dromaeo_css | took 1118834ms 16:09:29 INFO - TEST-START | kraken 16:09:29 INFO - operating with platform_type : linux_ 16:09:29 INFO - Initialising browser for kraken test... 16:09:29 INFO - TEST-INFO | started process 1722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1z03RP/profile http://localhost:45315/getInfo.html) 16:09:32 INFO - PROCESS | 1722 | JavaScript error: , line 0: uncaught exception: undefined 16:09:33 INFO - PROCESS | 1722 | __metrics Screen width/height:1600/1200 16:09:33 INFO - PROCESS | 1722 | colorDepth:24 16:09:33 INFO - PROCESS | 1722 | Browser inner width/height: 1024/697 16:09:33 INFO - PROCESS | 1722 | __metrics 16:09:34 INFO - PROCESS | 1722 | 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" 16:09:34 INFO - PROCESS | 1722 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:09:35 INFO - TEST-INFO | 1722: exit 0 16:09:35 INFO - Browser initialized. 16:09:35 INFO - Running cycle 1/1 for kraken test... 16:09:35 INFO - TEST-INFO | started process 1802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1z03RP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:09:47 INFO - PROCESS | 1802 | RSS: Main: 159485952 16:09:47 INFO - PROCESS | 1802 | 16:09:50 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45315/tests/kraken/driver.html?testName=audio-beat-detection) 16:09:50 INFO - PROCESS | 1802 | RSS: Main: 215564288 16:09:50 INFO - PROCESS | 1802 | 16:09:53 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45315/tests/kraken/driver.html?testName=audio-dft) 16:09:54 INFO - PROCESS | 1802 | RSS: Main: 192897024 16:09:54 INFO - PROCESS | 1802 | 16:09:57 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45315/tests/kraken/driver.html?testName=audio-fft) 16:09:58 INFO - PROCESS | 1802 | RSS: Main: 273367040 16:09:58 INFO - PROCESS | 1802 | 16:10:00 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45315/tests/kraken/driver.html?testName=audio-oscillator) 16:10:01 INFO - PROCESS | 1802 | RSS: Main: 182050816 16:10:01 INFO - PROCESS | 1802 | 16:10:03 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:03 INFO - PROCESS | 1802 | RSS: Main: 186843136 16:10:03 INFO - PROCESS | 1802 | 16:10:07 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45315/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:07 INFO - PROCESS | 1802 | RSS: Main: 223010816 16:10:07 INFO - PROCESS | 1802 | 16:10:11 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45315/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:11 INFO - PROCESS | 1802 | RSS: Main: 223059968 16:10:11 INFO - PROCESS | 1802 | 16:10:14 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45315/tests/kraken/driver.html?testName=json-parse-financial) 16:10:15 INFO - PROCESS | 1802 | RSS: Main: 222240768 16:10:15 INFO - PROCESS | 1802 | 16:10:16 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:17 INFO - PROCESS | 1802 | RSS: Main: 186945536 16:10:17 INFO - PROCESS | 1802 | 16:10:19 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:20 INFO - PROCESS | 1802 | RSS: Main: 193372160 16:10:20 INFO - PROCESS | 1802 | 16:10:22 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:23 INFO - PROCESS | 1802 | RSS: Main: 197750784 16:10:23 INFO - PROCESS | 1802 | 16:10:25 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:26 INFO - PROCESS | 1802 | RSS: Main: 191664128 16:10:26 INFO - PROCESS | 1802 | 16:10:29 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:10:29 INFO - PROCESS | 1802 | RSS: Main: 194998272 16:10:29 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:45315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45315/tests/kraken/driver.html?testName=ai-astar) 16:10:31 INFO - PROCESS | 1802 | RSS: Main: 245329920 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | __start_tp_report 16:10:31 INFO - PROCESS | 1802 | _x_x_mozilla_page_load 16:10:31 INFO - PROCESS | 1802 | _x_x_mozilla_page_load_details 16:10:31 INFO - PROCESS | 1802 | |i|pagename|runs| 16:10:31 INFO - PROCESS | 1802 | |0;ai-astar;104;114;113;115;113;112;112;112;112;113 16:10:31 INFO - PROCESS | 1802 | |1;audio-beat-detection;156;129;159;171;122;157;152;122;188;122 16:10:31 INFO - PROCESS | 1802 | |2;audio-dft;162;163;161;162;161;163;161;162;161;160 16:10:31 INFO - PROCESS | 1802 | |3;audio-fft;75;76;76;119;77;76;75;76;102;78 16:10:31 INFO - PROCESS | 1802 | |4;audio-oscillator;85;85;123;85;89;85;128;85;85;128 16:10:31 INFO - PROCESS | 1802 | |5;imaging-gaussian-blur;118;117;117;118;117;118;118;118;117;117 16:10:31 INFO - PROCESS | 1802 | |6;imaging-darkroom;146;146;146;146;146;146;146;148;147;147 16:10:31 INFO - PROCESS | 1802 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;94;95 16:10:31 INFO - PROCESS | 1802 | |8;json-parse-financial;62;61;61;61;70;63;61;61;62;60 16:10:31 INFO - PROCESS | 1802 | |9;json-stringify-tinderbox;66;66;66;65;67;66;66;67;66;65 16:10:31 INFO - PROCESS | 1802 | |10;stanford-crypto-aes;80;79;79;78;79;79;81;79;79;83 16:10:31 INFO - PROCESS | 1802 | |11;stanford-crypto-ccm;131;130;137;132;132;128;137;130;174;132 16:10:31 INFO - PROCESS | 1802 | |12;stanford-crypto-pbkdf2;165;164;167;164;167;167;173;165;163;166 16:10:31 INFO - PROCESS | 1802 | |13;stanford-crypto-sha256-iterative;66;68;68;67;68;66;66;66;66;66 16:10:31 INFO - PROCESS | 1802 | __end_tp_report 16:10:31 INFO - PROCESS | 1802 | __start_cc_report 16:10:31 INFO - PROCESS | 1802 | _x_x_mozilla_cycle_collect,1995 16:10:31 INFO - PROCESS | 1802 | __end_cc_report 16:10:31 INFO - PROCESS | 1802 | __startTimestamp1469747431824__endTimestamp 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | ------- Summary: start ------- 16:10:31 INFO - PROCESS | 1802 | Number of tests: 14 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.98 (2.6%) stddev-sans-first:1.05 16:10:31 INFO - PROCESS | 1802 | Values: 104.0 114.0 113.0 115.0 113.0 112.0 112.0 112.0 112.0 113.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:156.50 stddev:23.09 (14.8%) stddev-sans-first:24.30 16:10:31 INFO - PROCESS | 1802 | Values: 156.0 129.0 159.0 171.0 122.0 157.0 152.0 122.0 188.0 122.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 16:10:31 INFO - PROCESS | 1802 | Values: 162.0 163.0 161.0 162.0 161.0 163.0 161.0 162.0 161.0 160.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.06 (19.8%) stddev-sans-first:15.70 16:10:31 INFO - PROCESS | 1802 | Values: 75.0 76.0 76.0 119.0 77.0 76.0 75.0 76.0 102.0 78.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:85.00 stddev:19.78 (23.3%) stddev-sans-first:20.43 16:10:31 INFO - PROCESS | 1802 | Values: 85.0 85.0 123.0 85.0 89.0 85.0 128.0 85.0 85.0 128.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:10:31 INFO - PROCESS | 1802 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:10:31 INFO - PROCESS | 1802 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 148.0 147.0 147.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:10:31 INFO - PROCESS | 1802 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:61.50 stddev:2.86 (4.6%) stddev-sans-first:3.03 16:10:31 INFO - PROCESS | 1802 | Values: 62.0 61.0 61.0 61.0 70.0 63.0 61.0 61.0 62.0 60.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 16:10:31 INFO - PROCESS | 1802 | Values: 66.0 66.0 66.0 65.0 67.0 66.0 66.0 67.0 66.0 65.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:1.43 (1.8%) stddev-sans-first:1.51 16:10:31 INFO - PROCESS | 1802 | Values: 80.0 79.0 79.0 78.0 79.0 79.0 81.0 79.0 79.0 83.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:132.00 stddev:13.56 (10.3%) stddev-sans-first:14.24 16:10:31 INFO - PROCESS | 1802 | Values: 131.0 130.0 137.0 132.0 132.0 128.0 137.0 130.0 174.0 132.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.50 stddev:2.81 (1.7%) stddev-sans-first:2.95 16:10:31 INFO - PROCESS | 1802 | Values: 165.0 164.0 167.0 164.0 167.0 167.0 173.0 165.0 163.0 166.0 16:10:31 INFO - PROCESS | 1802 | 16:10:31 INFO - PROCESS | 1802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 16:10:31 INFO - PROCESS | 1802 | Values: 66.0 68.0 68.0 67.0 68.0 66.0 66.0 66.0 66.0 66.0 16:10:31 INFO - PROCESS | 1802 | -------- Summary: end -------- 16:10:31 INFO - PROCESS | 1802 | 16:10:32 INFO - TEST-INFO | 1802: exit 0 16:10:32 INFO - TEST-OK | kraken | took 63154ms 16:10:32 INFO - SUITE-END | took 1181s 16:10:32 INFO - Completed test suite (00:19:42) 16:10:32 INFO - javascript benchmark 16:10:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2629.73702629737, 2637.5911733681264, 2662.7071022187556, 2670.0387860370274, 2674.478476697044, 4664.76676166192, 4751.02603966187, 4777.832775852846, 4851.514848515147, 4854.368932038835, 4765.118453086173, 4803.903921921568, 4808.783604737787, 4827.420709514854, 4862.61099112071, 4340.696151269412, 4351.978240108795, 4389.990302230489, 4467.374567560544, 4535.614472769818, 4488.596026357627, 4520.819167233323, 4522.366868638377, 4544.727316361029, 4549.0, 4326.9567304326865, 4330.545292744248, 4396.318570621559, 4411.801468933906, 4430.6898517103655, 4341.435613370273, 4372.060007098457, 4374.562543745632, 4446.888827779331, 4480.84317048905, 4407.316865885793, 4412.271975124133, 4419.138268037734, 4425.712328698624, 4435.800388982503, 4707.764611769432, 4730.716157030589, 4797.544233297831, 4889.046635906, 4893.339399181101, 5129.563987061104, 5171.327727395452, 5206.921896171522, 5218.112920803473, 5224.451432599561, 5207.3490813648295, 5215.817446389358, 5244.737763111867, 5260.684358938476, 5268.1834315681135, 4694.929576056362, 4780.020095880405, 4812.1578723723205, 4893.0, 4896.510348965075, 5304.0, 5328.813491527778, 5365.248865158881, 5379.596530260168, 5385.246065550826, 5101.923471147936, 5106.029854327666, 5142.151544995108, 5154.974225128925, 5159.1229490986625, 5008.549230569266, 5083.593312534988, 5142.023015627019, 5190.169572868398, 5237.423883372826, 5107.489251074863, 5108.872278193001, 5116.437191908887, 5145.665531740499, 5163.7676304566385, 5086.9745651271505, 5099.821506247264, 5102.897942041212, 5116.984509808767, 5162.09663308927, 4232.703710740218, 4303.182395344875, 4321.373400856858, 4383.802728877208, 4435.82256709728, 3799.164183879542, 3834.616538346143, 3863.9227215456094, 3882.301185786529, 3912.4718163047623, 4418.779061046999, 4420.071784925138, 4426.9778651106535, 4434.623057040123, 4477.082198149372, 5003.2995380646735, 5063.088644044107, 5179.741012949337, 5204.687718736888, 5238.71187084714, 4347.673924455678, 4392.231359512072, 4408.713433626868, 4423.579759922803, 4434.977825110854, 4626.074785043005, 4633.49031606523, 4635.281531362644, 4646.001109761418, 4689.0, 4813.109574728686, 4862.149123903374, 4869.415670119608, 4877.219644856806, 4912.729799861042, 5070.4929507049, 5085.0, 5093.363329583802, 5107.668001579886, 5208.5051920069045, 4823.975880120577, 4824.324594556835, 4829.830955916526, 4837.331974644485, 4879.56083952446, 5122.103631864484, 5126.846194614168, 5130.179171332569, 5130.358705161855, 5178.067947769287, 4959.20652695567, 5090.643654944119, 5117.692938423706, 5147.871303217449, 5211.895762084813, 5031.6729412588065, 5048.293238946624, 5048.671836330626, 5053.924191137063, 5097.2608971698155, 5012.47369026247, 5028.2960385546785, 5031.270465782514, 5031.7484125792835, 5036.974815125901, 4810.374651295309, 4905.975470122627, 4952.504749525018, 4966.6771659842, 5025.422076461254, 5054.317667114892, 5060.645754797129, 5066.544011039025, 5072.51811077947, 5127.4103478099005, 4908.852734417973, 4923.630727695366, 4926.827561035347, 4926.8768280793265, 4972.900541989067], "value": 4730.543296315817, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7696482924415, 579.0185635348084, 583.5098517245513, 595.6664268009912, 599.3886236039243, 27231.45537089257, 38802.0, 40310.0, 40378.79810600947, 44382.77808610952, 41124.38313425301, 41466.378004329956, 41608.37587436191, 41625.0, 41631.375529367084, 7405.111386633612, 7615.048118985127, 7740.419468539854, 7757.650905709256, 7759.146493885668, 9647.421154730704, 9899.20806335495, 9900.306978511471, 10200.846987295197, 10210.978902109766, 9818.607255709763, 9893.901060989407, 9898.703038908845, 9906.65326713565, 9908.306418550668, 9894.505274736235, 9907.0, 9922.0, 9953.452560109155, 9958.850617240747, 9804.215662747034, 9857.211423086208, 9869.753256168582, 9870.407775533491, 9871.259655525864, 38924.61075389238, 39121.60878391208, 39163.60836391628, 39176.0, 39247.41128883069, 3082.214035420953, 3246.3020450603, 3670.632936706308, 3724.2179142380132, 3766.6986641068647, 27298.0, 29328.0, 29615.259618509495, 30188.698113018807, 30416.0, 3368.1747971746836, 3414.5561077059824, 3487.442009278503, 3490.7556471047037, 3502.842372093262, 260790.0, 263676.0, 263682.0, 263785.68107159535, 264639.7680115987, 54883.72558137264, 55315.72342138264, 55317.723411382685, 55349.169762453595, 55372.0, 32728.0, 33764.83117584397, 34009.149771255914, 35688.64311356905, 57165.42834571601, 15797.289121989537, 15946.36214551405, 15948.76076858848, 15955.680886382208, 15958.441454549267, 11170.609028683957, 11866.110041746904, 12111.576094836639, 12148.392580371123, 12219.083568732382, 18105.0, 18163.18265678048, 18236.726449103273, 18272.908635457003, 18302.633947320977, 6926.545425460609, 7034.366906978396, 7077.5753454792875, 7134.751418501742, 7206.531575447579, 869.8869147010848, 870.1168314161132, 870.4037734152126, 894.7449976756593, 909.60432211988, 28217.43565128727, 28854.855725721238, 28947.42105157885, 29243.268918277212, 29435.705642943725, 928.7956649537091, 965.5944503308627, 1009.7728011197422, 1040.8074506216374, 1081.113486940701, 14899.957003009686, 14956.326965286587, 15365.308561114776, 15482.767758483631, 15548.611284717972, 384620.0, 389312.0, 389676.0, 391265.0, 391282.0, 49866.0, 50262.0, 50559.49440505621, 50638.24042639363, 50725.74637126791, 1076.219740687995, 1110.5502271580024, 1147.925384849982, 1156.670348950545, 1213.6055781870928, 27046.45907081808, 29621.407571848875, 29763.107106786832, 30560.84719576388, 30602.0, 43450.0, 43904.34143487786, 43910.34134488049, 43985.0, 43995.34006989834, 318006.0, 318449.0, 320032.0, 320176.0, 320475.0, 25214.621780672936, 25937.0, 26111.08611198599, 26149.084782032536, 27247.318817029733, 41838.1632367357, 42061.36907946444, 42198.57801422069, 42296.1540769189, 43253.56746432495, 35588.466173006906, 35927.10182245465, 36154.63845361618, 36712.26575468529, 36914.44628330523, 36900.023413720526, 37259.627403725615, 37503.06242343963, 37591.43612845755, 38391.42412863753, 35835.82082089573, 36554.634453655126, 36678.26643467169, 36954.0, 36991.81504092462, 31525.842370788, 33116.69231497125, 33828.83085584556, 33832.66167338393, 33835.0, 25199.748002520475, 25438.364040899127, 25600.487990240465, 25812.61281080823, 25825.6126158104], "value": 18183.201565498377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.1071052749695, 361.96199399063113, 367.4836854219821, 369.89088218975405, 379.9962000379997, 13026.023048271381, 15994.280257388416, 16252.837471625295, 17306.653866922654, 17525.912370438164, 16291.83708162921, 16574.254158562864, 16823.0, 16897.662046759087, 17549.385771498, 5048.066107770056, 5074.670146440479, 5161.406438259592, 5209.7134657593815, 5219.5041471060185, 3672.889813305605, 5143.254228136918, 5227.712475813829, 5728.885422291552, 6049.395060493959, 6074.088886667013, 6074.5747797654185, 6091.664958427285, 6106.786262480814, 6113.0, 5933.465988061073, 5979.192808970777, 6038.2150320458495, 6063.423974722395, 6068.817935461943, 5163.896722065575, 5307.071262529081, 5316.308879845634, 5320.547753440962, 5320.600954928396, 20788.168473261052, 20885.164593416244, 21106.472338191514, 21115.577688446298, 21129.47176320589, 1873.100911562444, 1893.4698284480367, 1957.530192753743, 1960.8529360297891, 1998.540335722792, 12756.425960831784, 13319.200847949154, 13359.1316564423, 13715.177089374669, 13880.58358249244, 1635.386729976259, 1725.6289897672061, 1754.4648882090958, 1791.2924394863956, 1794.9282028718835, 67563.0, 68612.6569367155, 69507.3049269511, 70754.29245707528, 72197.27802721958, 8385.287250583646, 8961.283097352196, 8995.820083598292, 9447.52762361893, 9685.6610018649, 11665.941670291595, 11731.120165987584, 11806.88193118075, 11820.586279480349, 11856.822147667792, 5677.602567820296, 5801.564882633819, 5806.0, 6356.713947872357, 7417.443691723142, 7322.487425880137, 7379.631018449056, 7403.51877127985, 7534.020577325023, 7639.69441222356, 3724.571674257441, 3725.2549490102087, 3764.924701506009, 3814.237152569497, 3823.5029446172375, 1814.6280012597385, 1838.9816101839078, 1840.1351364858494, 1850.9629807404046, 1858.50749551369, 762.9923700762921, 845.9534725590029, 883.4610887358706, 887.1970866365949, 924.861270809384, 16578.66842663164, 16776.66446671084, 17501.299948002194, 17723.46829595114, 17745.7338139928, 773.6325245508339, 827.0778082438038, 828.5185868324407, 889.3996552327153, 899.581694512055, 9423.38747981379, 9445.669401570913, 9909.20726341891, 9960.701178964642, 10069.496525173712, 375529.0, 377304.0, 377919.0, 378785.0, 380405.0, 76360.0, 77115.22884771193, 77640.447191057, 79483.0, 81019.0, 887.3921363865772, 898.3038145437338, 900.1808354397598, 901.5041727050096, 901.9549022548846, 15331.693366132838, 15603.0, 15870.0, 16140.112293823953, 16336.346546138497, 37129.81435092807, 37786.0, 38122.237555249296, 39837.80081099576, 40480.0, 54410.18384724153, 55934.16098758603, 56055.71972140113, 56805.431945680015, 56839.71580142073, 7642.7325043623205, 7722.343600793771, 7848.254415830487, 7955.2840244378285, 8129.3090087343235, 12076.0, 12163.817542737042, 12205.0, 12451.315177664954, 12653.493860245855, 4906.803727850989, 7215.8556828864175, 7334.4132469403385, 10407.0, 11124.777504450027, 10659.25385223058, 10677.786444270916, 10681.19891008193, 10929.726756831144, 11039.724006899893, 10664.946675266574, 10737.89262107369, 10925.726856828644, 11064.0, 11073.065637606202, 6691.0, 7050.118735158106, 7152.570845749272, 7941.642626081955, 8014.0383154019555, 10390.948045259725, 10463.843042354523, 10593.947030264799, 10659.200559957879, 10917.56329746833], "value": 8241.617336270636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.50210166984, 1318.06417443615, 1374.7181827725315, 1433.2403825972233, 1671.4317132175058, 6694.966525167373, 7483.10202775667, 7726.536407815528, 7743.18696536864, 7990.92009079909, 7839.451238413313, 7860.331871790904, 7898.328642065431, 7901.960490197555, 7907.8418431631335, 2159.6436587962967, 2180.6183917814396, 2183.7597864235, 2184.421128400975, 2201.8348623853194, 2148.4414052346347, 2180.3785921012513, 2213.9557208855813, 2218.6117429449864, 2220.8667479951173, 2134.8719076855436, 2144.5710857828417, 2160.2547121243147, 2162.7296587926508, 2196.769339219383, 2141.100737690166, 2142.7964343387353, 2144.345974477784, 2144.5710857828417, 2144.6354119799516, 2094.832413406939, 2133.7119488868957, 2136.060133541237, 2137.5831712815852, 2137.7648458669532, 7446.180920098785, 7861.017372828396, 7878.369730421553, 7917.089534703525, 7919.208079192093, 4585.564371384713, 4704.929426058612, 4755.262934245163, 4780.282957556359, 4786.497417771154, 2794.538901081319, 2930.3846192299643, 3019.21500409895, 3020.4714175019285, 3030.030390275113, 880.2517859819167, 881.8941726992801, 896.9775755606097, 900.4372267332917, 905.4069584422214, 10551.0, 10674.146068314594, 10714.9464252679, 10740.033396994308, 10747.51636176366, 4099.877003689894, 4235.661147108224, 4377.212101821703, 4435.645148388121, 4440.777961101932, 9270.304727145356, 9274.026227246177, 9283.72148835536, 9290.860637090449, 9295.07049295065, 4612.95387046132, 4619.3071039343695, 4625.606823419979, 4681.157391669532, 4697.95302046982, 3682.4844521766972, 3746.6253374662315, 3900.8244628991765, 4211.0946146578635, 4213.073123912734, 3636.927261454809, 3740.532433445819, 3831.5210598675167, 3844.826982785781, 3847.2690188864026, 1198.4427241332821, 1236.4744983382027, 1236.7959286717771, 1243.210561293567, 1258.5154715434442, 831.4927893984665, 837.4891316297054, 840.8528507511284, 842.2083241752733, 878.7188099808128, 5265.1049321614655, 5266.183741520071, 5295.470452954673, 5379.35447746273, 5494.945050549443, 408.6403964511211, 419.24954331745835, 426.44775016353896, 427.7177063138376, 430.7071191589686, 3637.418013117888, 3762.2851658185405, 3828.5214348206473, 3844.1927195288745, 3844.9038774030873, 9361.719148425558, 9756.170725488271, 9787.46168960714, 9794.902050979541, 9804.852927206097, 9686.806263874683, 9707.6116955321, 9727.0, 9727.173190278905, 9727.951360243154, 7363.079615048119, 7420.183779784219, 7420.5176663516695, 7427.145878223965, 7448.813779655552, 5278.8944221116135, 5331.5201631853315, 5334.306540149756, 5339.65055375649, 5447.564194864322, 8719.12808719123, 8793.516356600448, 8815.735527934172, 8925.107489251022, 9004.0, 8830.514321712111, 8904.910950890408, 8980.685676001309, 8990.775230619287, 9099.727008189764, 6601.042848786995, 6682.966585167043, 6686.197656281277, 6692.966535167293, 6694.0628312037325, 7292.0520332356455, 7395.371393431618, 7400.259974002557, 7450.925490745023, 7490.5131166474, 6808.455323574201, 6829.897551536632, 6845.897311540431, 6851.657417129024, 6907.378335949788, 6644.402003819486, 6656.30108838565, 6687.264400915798, 6700.83247918806, 6714.328567143247, 5828.6502809831545, 5918.496927761016, 5923.141144533933, 5927.110933360031, 5932.5550583705535, 4594.88512787183, 4670.0, 4777.976110119427, 4822.228443449031, 4848.418189817245, 4636.188666983332, 4673.205555055581, 4720.858374248778, 4727.645426592951, 4877.073356062337], "value": 4073.5098409116904, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.7444611518805, 294.5949319685433, 301.7209081599521, 303.3977554554211, 304.3092180749697, 4862.756862156892, 4916.483769204236, 4926.876828079296, 4934.703917764928, 4943.579795717359, 4625.884352891171, 4722.1972264715, 4762.523747625244, 4830.541098595637, 4875.536824001723, 3848.230353929225, 3855.132595166079, 3855.807209639521, 3871.412720784479, 3880.0881792778746, 3846.576876543578, 3847.2305538892333, 3866.2074274773745, 3871.7870517121546, 3873.283442563121, 3678.7792732436005, 3707.1288247261873, 3791.924161516768, 3822.7706337619693, 3827.7559793067226, 3816.713746468998, 3822.3502004659276, 3849.7690138591634, 3854.1906199698096, 3854.383298672199, 3358.2947581008016, 3365.7980521168806, 3370.865165393381, 3371.0729549373873, 3408.3183363327184, 4638.6084174747775, 4708.764561771898, 4744.14605371033, 4748.548887855648, 4796.304535842318, 4334.154839806208, 4339.47926248849, 4345.913081738379, 4365.0, 4400.537943515917, 5060.165072762989, 5067.6452648314635, 5112.923306150411, 5119.6160287978555, 5129.589632829402, 3680.907977300562, 3688.944665830015, 3694.9284707434813, 3717.4052151655605, 3736.1132628022674, 5213.244079608436, 5263.894722105575, 5271.367435907678, 5297.682139071668, 5299.364076310829, 3762.9435558466644, 3777.6033516480925, 3786.8295926683363, 3787.579657628389, 3795.9750867266234, 3842.212346468967, 3846.9230615387537, 3850.403187505941, 3864.686006757716, 3895.590962948906, 4236.76697781625, 4308.6983911126545, 4370.409994650745, 4398.890027749268, 4403.229434848889, 5043.823466178739, 5059.988002399461, 5065.848024559269, 5069.594432445396, 5128.8717782055, 1264.8039553869164, 1319.4788058716754, 1331.6138319887318, 1333.9599812005656, 1344.836716240445, 887.3078998381272, 917.821024900138, 929.5909799688116, 931.7391130483476, 934.5934518484481, 4482.058767658763, 4484.520108364232, 4490.775461226991, 4492.124035813051, 4495.707778994355, 5252.317198764213, 5262.71055091966, 5263.184206448007, 5271.499207575274, 5278.2346559749385, 4339.088791353851, 4450.35469856869, 4467.486239082482, 4474.507804141542, 4482.148391805612, 2746.6703995520666, 2755.435135797157, 2759.9310017249327, 2763.6269103671148, 2777.222377734238, 4881.731504767272, 4902.338184345068, 4907.460179380265, 4912.6561140719805, 4915.16442204826, 5106.642535022513, 5244.715044814045, 5247.921281180786, 5255.290535777697, 5283.128283833202, 4845.9757701211265, 4906.2640603909695, 4919.729414882144, 4925.999999999928, 4936.308916751729, 5131.435542090292, 5199.620246839585, 5217.921731173959, 5268.710220937885, 5280.049591073644, 4945.77744001528, 5171.198464238049, 5177.119889618699, 5189.818356357509, 5211.76547055391, 4994.225894986283, 4996.15065438869, 4996.900061998813, 5007.273945277987, 5017.218887294957, 3712.573054098705, 3736.551613806361, 3740.925181496409, 3746.0, 3762.3792074308526, 5162.387044824229, 5282.683039017671, 5296.3379577552805, 5327.413984461784, 5360.892782144258, 5118.360204974379, 5145.639805213599, 5149.382074151126, 5153.175491921274, 5193.818216362409, 5020.322256495327, 5141.126008578476, 5141.742912854417, 5158.38099428071, 5159.716215608028, 4829.13075646387, 5028.094942910311, 5038.7984480621835, 5054.418741844588, 5056.216286475602, 5001.424836143745, 5042.9243561345875, 5168.922466162935, 5189.922151167811, 5196.636235463481, 4993.925091123563, 5050.949490505048, 5052.621053420935, 5060.2156665716875, 5063.696178229171], "value": 3863.0364002752854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.798431556797, 578.2396149063983, 581.3575998521634, 583.6517644241802, 590.7489317040257, 11045.282056666321, 12092.818607720868, 12106.031517478603, 12176.81734773979, 12290.754184916297, 11473.368964706939, 11667.591634292801, 11763.35301558416, 11778.175527713063, 11792.233504822181, 758.9582572958485, 776.7825008997462, 776.9184235655259, 777.0985656638301, 777.4480119115435, 632.8038308124474, 751.1361933776174, 780.3679019993795, 782.4092809928496, 789.6801795272924, 823.6993497373445, 825.8843761873343, 825.8926339575877, 826.5949684654506, 826.7933016745814, 821.40858581821, 821.4988856797349, 821.6056292979373, 821.8109834738013, 822.839546288474, 483.8838678717083, 574.7815829984579, 590.0676930449879, 592.884387544429, 596.1415561591294, 12053.758924821455, 12092.576759813364, 12122.212056216318, 12147.453364598614, 12168.756624867454, 11297.49161287744, 11354.48904799286, 11357.375344356056, 11506.424678766029, 12034.939825300906, 11592.826107608393, 11647.76704465906, 11657.883421165765, 11789.351585662786, 11920.22518536301, 4071.653909417703, 4097.364908439196, 4146.108586653853, 4181.0592616661315, 4267.530571637118, 51043.46869593881, 53124.999999999614, 53871.730641346934, 60835.695821521054, 62140.06789898155, 9717.271204659679, 9816.214702823758, 9836.0, 9889.10998010168, 9897.455639939872, 15777.132257725936, 15787.210639467981, 15798.526044218692, 15809.051456912392, 15820.208989550476, 6780.32196780318, 6841.452683785285, 6841.863162736718, 6862.553933994274, 7079.079719636415, 3625.9456108158397, 3672.1737609037755, 3695.1685870678884, 3717.5353080864893, 3789.9242015159543, 2765.3916138449913, 2837.3474100956482, 2856.4858325501195, 2856.6429196350455, 2861.527847905114, 514.7966553211461, 517.4153206876206, 526.7866514061811, 532.2761044978826, 539.1965970703702, 501.9247112933089, 584.5440556366042, 598.1058317814808, 600.3696119074954, 603.5594016368076, 7534.397248220129, 7547.622618869144, 7596.696132154652, 7735.381169506539, 7773.222677732295, 476.7179649483712, 591.9230500034968, 594.690760804388, 595.9970200149058, 614.7233744814762, 3496.6328535503912, 3554.644535546425, 3632.9818350908076, 3714.201446688975, 3730.0363723450087, 56895.43104568984, 58377.416225838046, 60361.02238018759, 111891.0, 112048.43975780232, 89481.0, 91079.0, 91804.54097729469, 93776.0, 94277.0, 50353.49646503561, 67313.66343168252, 82706.58646706727, 82772.58613707013, 83021.58489207516, 6733.764318249034, 6819.795406137824, 6856.314368563303, 6870.656467176721, 7103.360697537039, 46387.76806115948, 47388.0, 47492.0, 48144.0, 49355.50644493509, 44615.0, 67958.0, 68864.65567672129, 69779.95330070154, 73401.26598733944, 8959.596818143069, 9138.406003609743, 9188.632454702005, 9492.810143797224, 9510.524473776422, 10165.745856353355, 10176.847347289648, 10222.897771022195, 10294.919033501674, 10366.792664146524, 9712.368696034735, 9960.601575937171, 10050.69847904564, 10078.94960525222, 10193.847092293474, 9278.628854846, 9490.667826626035, 9541.952290238782, 9632.373895696757, 9770.31607787448, 9546.140847323773, 9572.425654460754, 9744.75638109053, 10111.7472063199, 10134.037266459674, 8094.31198348147, 8140.389470789596, 8190.713325033834, 8426.4944103354, 8429.367797415342, 8043.235892590194, 8217.178282171735, 8453.535055572003, 8649.61076751535, 8785.428947118417], "value": 6161.555613448289, "unit": "score"}], "name": "dromaeo_css", "value": 6400.375020793294, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 115.0, 113.0, 112.0, 112.0, 112.0, 112.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 159.0, 171.0, 122.0, 157.0, 152.0, 122.0, 188.0, 122.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 161.0, 163.0, 161.0, 162.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 119.0, 77.0, 76.0, 75.0, 76.0, 102.0, 78.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 123.0, 85.0, 89.0, 85.0, 128.0, 85.0, 85.0, 128.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 70.0, 63.0, 61.0, 61.0, 62.0, 60.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 67.0, 66.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 78.0, 79.0, 79.0, 81.0, 79.0, 79.0, 83.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 137.0, 132.0, 132.0, 128.0, 137.0, 130.0, 174.0, 132.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 167.0, 164.0, 167.0, 167.0, 173.0, 165.0, 163.0, 166.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 67.0, 68.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1537.7999999999997, "alertThreshold": 2.0}]} 16:10:33 INFO - Return code: 0 16:10:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:10:33 INFO - # TBPL SUCCESS # 16:10:33 INFO - Running post-action listener: _resource_record_post_action 16:10:33 INFO - [mozharness: 2016-07-28 23:10:33.115865Z] Finished run-tests step (success) 16:10:33 INFO - Running post-run listener: _resource_record_post_run 16:10:33 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 537354240; Read time: 0; Write time: 492196 16:10:33 INFO - TinderboxPrint: CPU usage
13.0% 16:10:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:10:33 INFO - TinderboxPrint: I/O write bytes / time
537,354,240 / 492,196 16:10:33 INFO - TinderboxPrint: CPU idle
8,328.8 (87.0%) 16:10:33 INFO - TinderboxPrint: CPU user
1,199.0 (12.5%) 16:10:33 INFO - TinderboxPrint: Swap in / out
0 / 0 16:10:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252559360; Read time: 0; Write time: 251392 16:10:33 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 284475392; Read time: 0; Write time: 240780 16:10:33 INFO - Running post-run listener: _upload_blobber_files 16:10:33 INFO - Blob upload gear active. 16:10:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:10:33 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 16:10:33 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:10:33 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:10:34 INFO - (blobuploader) - INFO - Open directory for files ... 16:10:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:10:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:10:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:40 INFO - (blobuploader) - INFO - Done attempting. 16:10:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:10:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:10:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:40 INFO - (blobuploader) - INFO - Done attempting. 16:10:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:10:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:10:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:41 INFO - (blobuploader) - INFO - Done attempting. 16:10:41 INFO - (blobuploader) - INFO - Iteration through files over. 16:10:41 INFO - Return code: 0 16:10:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:10:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:10:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/588ff623271dd64ca587500e0846ecbd5ad24990145b7615ff4f78a1ae77997bcbc87236e8c2d7665324421527efb924c7d2b57dda037dbaa16fc63876d733b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/177fbd9f97b9fd90b1f12579839b90adac5ddc4a98dd340dd226dd92791bec5293510470aac635ee0c9c4786bbfd1c3f5db83dcbf5a25caccec1ab496571c605", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d4e78c99ef026ebeddbccca52f7d4e1643f5a6546630c35a97dcb6e7ad6e4272821d0958bf9e81c0c28746af57910864ef65484c5f6ce069e0e83679dca8a35"} 16:10:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:10:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:10:41 INFO - Contents: 16:10:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/588ff623271dd64ca587500e0846ecbd5ad24990145b7615ff4f78a1ae77997bcbc87236e8c2d7665324421527efb924c7d2b57dda037dbaa16fc63876d733b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/177fbd9f97b9fd90b1f12579839b90adac5ddc4a98dd340dd226dd92791bec5293510470aac635ee0c9c4786bbfd1c3f5db83dcbf5a25caccec1ab496571c605", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d4e78c99ef026ebeddbccca52f7d4e1643f5a6546630c35a97dcb6e7ad6e4272821d0958bf9e81c0c28746af57910864ef65484c5f6ce069e0e83679dca8a35"} 16:10:41 INFO - Running post-run listener: copy_logs_to_upload_dir 16:10:41 INFO - Copying logs to upload dir... 16:10:41 INFO - mkdir: /builds/slave/test/build/upload/logs 16:10:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.827348 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-28 16:10:41.399862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 16:10:41.404075) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/588ff623271dd64ca587500e0846ecbd5ad24990145b7615ff4f78a1ae77997bcbc87236e8c2d7665324421527efb924c7d2b57dda037dbaa16fc63876d733b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/177fbd9f97b9fd90b1f12579839b90adac5ddc4a98dd340dd226dd92791bec5293510470aac635ee0c9c4786bbfd1c3f5db83dcbf5a25caccec1ab496571c605", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d4e78c99ef026ebeddbccca52f7d4e1643f5a6546630c35a97dcb6e7ad6e4272821d0958bf9e81c0c28746af57910864ef65484c5f6ce069e0e83679dca8a35"} build_url:https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/Z1RpA_i4ShyFGZjRxbDd_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/588ff623271dd64ca587500e0846ecbd5ad24990145b7615ff4f78a1ae77997bcbc87236e8c2d7665324421527efb924c7d2b57dda037dbaa16fc63876d733b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/177fbd9f97b9fd90b1f12579839b90adac5ddc4a98dd340dd226dd92791bec5293510470aac635ee0c9c4786bbfd1c3f5db83dcbf5a25caccec1ab496571c605", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d4e78c99ef026ebeddbccca52f7d4e1643f5a6546630c35a97dcb6e7ad6e4272821d0958bf9e81c0c28746af57910864ef65484c5f6ce069e0e83679dca8a35"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 16:10:41.432353) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:10:41.432881) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469746141.840074-906902813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:10:41.517204) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 16:10:41.517589) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 16:10:41.517893) ========= ========= Total master_lag: 0.17 =========