builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1470122520.38 results: success (0) buildid: 20160801234249 builduid: 5490a327531c4afdbafcae2ed00b4f1c revision: a8e4a7ff0197fa9f9d77113ce31742641e71782a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:00.378611) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:00.379431) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:00.379709) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:00.431511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:00.431790) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 00:22:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-08-02 00:22:00 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:00.567405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:00.567723) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014639 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:00.621476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:00.621807) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a8e4a7ff0197fa9f9d77113ce31742641e71782a --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 a8e4a7ff0197fa9f9d77113ce31742641e71782a --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=03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 00:22:00,932 truncating revision to first 12 chars 2016-08-02 00:22:00,932 Setting DEBUG logging. 2016-08-02 00:22:00,932 attempt 1/10 2016-08-02 00:22:00,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a8e4a7ff0197?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 00:22:01,236 unpacking tar archive at: autoland-a8e4a7ff0197/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:01.313585) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:01.314087) ========= script_repo_revision: a8e4a7ff0197fa9f9d77113ce31742641e71782a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:01.315040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:01.316019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 00:22:01.336112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-08-02 00:22:01.336389) ========= /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=03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:22:01 INFO - MultiFileLogger online at 20160802 00:22:01 in /builds/slave/test 00:22:01 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 00:22:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:22:01 INFO - {'append_to_log': False, 00:22:01 INFO - 'base_work_dir': '/builds/slave/test', 00:22:01 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 00:22:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:22:01 INFO - 'branch': 'Autoland-Non-PGO', 00:22:01 INFO - 'buildbot_json_path': 'buildprops.json', 00:22:01 INFO - 'config_files': ('talos/linux_config.py',), 00:22:01 INFO - 'default_actions': ('clobber', 00:22:01 INFO - 'read-buildbot-config', 00:22:01 INFO - 'download-and-extract', 00:22:01 INFO - 'populate-webroot', 00:22:01 INFO - 'create-virtualenv', 00:22:01 INFO - 'install', 00:22:01 INFO - 'run-tests'), 00:22:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:22:01 INFO - 'download_minidump_stackwalk': True, 00:22:01 INFO - 'download_symbols': 'ondemand', 00:22:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:22:01 INFO - 'tooltool.py': '/tools/tooltool.py', 00:22:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:22:01 INFO - '/tools/misc-python/virtualenv.py')}, 00:22:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:22:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:22:01 INFO - 'installer_path': 'installer.exe', 00:22:01 INFO - 'log_level': 'info', 00:22:01 INFO - 'log_name': 'talos', 00:22:01 INFO - 'log_to_console': True, 00:22:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:22:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:22:01 INFO - 'opt_config_files': (), 00:22:01 INFO - 'pip_index': False, 00:22:01 INFO - 'sps_profile': False, 00:22:01 INFO - 'sps_profile_interval': 0, 00:22:01 INFO - 'suite': 'dromaeojs', 00:22:01 INFO - 'system_bits': '32', 00:22:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:22:01 INFO - 'title': 'talos-linux64-ix-047', 00:22:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:22:01 INFO - 'use_talos_json': True, 00:22:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:22:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:22:01 INFO - 'work_dir': 'build'} 00:22:01 INFO - [mozharness: 2016-08-02 07:22:01.748348Z] Running clobber step. 00:22:01 INFO - Running pre-action listener: _resource_record_pre_action 00:22:01 INFO - Running main action method: clobber 00:22:01 INFO - rmtree: /builds/slave/test/build 00:22:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:22:02 INFO - Running post-action listener: _resource_record_post_action 00:22:02 INFO - [mozharness: 2016-08-02 07:22:02.215115Z] Finished clobber step (success) 00:22:02 INFO - [mozharness: 2016-08-02 07:22:02.215217Z] Running read-buildbot-config step. 00:22:02 INFO - Running pre-action listener: _resource_record_pre_action 00:22:02 INFO - Running main action method: read_buildbot_config 00:22:02 INFO - Using buildbot properties: 00:22:02 INFO - { 00:22:02 INFO - "project": "", 00:22:02 INFO - "product": "firefox", 00:22:02 INFO - "script_repo_revision": "production", 00:22:02 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 00:22:02 INFO - "repository": "", 00:22:02 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 00:22:02 INFO - "buildid": "20160801234249", 00:22:02 INFO - "pgo_build": "False", 00:22:02 INFO - "basedir": "/builds/slave/test", 00:22:02 INFO - "buildnumber": 125, 00:22:02 INFO - "slavename": "talos-linux64-ix-047", 00:22:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:22:02 INFO - "platform": "ubuntu64_hw", 00:22:02 INFO - "scheduler": "tests-autoland-linux64-talos", 00:22:02 INFO - "branch": "autoland", 00:22:02 INFO - "repo_path": "integration/autoland", 00:22:02 INFO - "revision": "a8e4a7ff0197fa9f9d77113ce31742641e71782a", 00:22:02 INFO - "stage_platform": "linux64", 00:22:02 INFO - "builduid": "5490a327531c4afdbafcae2ed00b4f1c", 00:22:02 INFO - "slavebuilddir": "test" 00:22:02 INFO - } 00:22:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 00:22:02 INFO - Running post-action listener: _resource_record_post_action 00:22:02 INFO - [mozharness: 2016-08-02 07:22:02.217673Z] Finished read-buildbot-config step (success) 00:22:02 INFO - [mozharness: 2016-08-02 07:22:02.217762Z] Running download-and-extract step. 00:22:02 INFO - Running pre-action listener: _resource_record_pre_action 00:22:02 INFO - Running main action method: download_and_extract 00:22:02 INFO - mkdir: /builds/slave/test/build/tests 00:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:02 INFO - https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:22:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:22:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:22:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:22:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:22:10 INFO - Downloaded 1361 bytes. 00:22:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:22:10 INFO - Using the following test package requirements: 00:22:10 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:22:10 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:22:10 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:22:10 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:10 INFO - u'jsshell-linux-x86_64.zip'], 00:22:10 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:22:10 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:22:10 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:22:10 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:22:10 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:22:10 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:22:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:22:10 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:10 INFO - https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:22:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:22:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:22:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:22:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:22:18 INFO - Downloaded 20237689 bytes. 00:22:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:22:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:22:19 INFO - Return code: 0 00:22:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:22:19 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')]} 00:22:19 INFO - https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:22:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:22:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:22:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:22:23 INFO - Downloaded 20237689 bytes. 00:22:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:22:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:22:24 INFO - Return code: 0 00:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:24 INFO - https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:22:26 INFO - Downloaded 14413723 bytes. 00:22:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:22:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:22:26 INFO - Return code: 0 00:22: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')]} 00:22:26 INFO - https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:22:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:22:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:22:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:22:28 INFO - Downloaded 55683830 bytes. 00:22:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:22:28 INFO - mkdir: /builds/slave/test/properties 00:22:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:22:28 INFO - Writing to file /builds/slave/test/properties/build_url 00:22:28 INFO - Contents: 00:22:28 INFO - build_url:https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:22:29 INFO - Running post-action listener: _resource_record_post_action 00:22:29 INFO - Running post-action listener: set_extra_try_arguments 00:22:29 INFO - [mozharness: 2016-08-02 07:22:29.372257Z] Finished download-and-extract step (success) 00:22:29 INFO - [mozharness: 2016-08-02 07:22:29.372489Z] Running populate-webroot step. 00:22:29 INFO - Running pre-action listener: _resource_record_pre_action 00:22:29 INFO - Running main action method: populate_webroot 00:22:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:22:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:22:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:22:29 INFO - '--tppagecycles', 00:22:29 INFO - '7'], 00:22:29 INFO - 'tests': ['tsvgm']}}, 00:22:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:22:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:22:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:22:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:22:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:29 INFO - 'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:22:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:22:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:29 INFO - 'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['damp', 'tps']}, 00:22:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:29 INFO - 'tests': ['damp', 'tps']}, 00:22:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['dromaeo_dom']}, 00:22:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:22:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['basic_compositor_video']}, 00:22:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:22:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['a11yr', 00:22:29 INFO - 'ts_paint', 00:22:29 INFO - 'tpaint', 00:22:29 INFO - 'sessionrestore', 00:22:29 INFO - 'sessionrestore_no_auto_restore', 00:22:29 INFO - 'tabpaint']}, 00:22:29 INFO - 'other-e10s': {'tests': ['a11yr', 00:22:29 INFO - 'ts_paint', 00:22:29 INFO - 'tpaint', 00:22:29 INFO - 'sessionrestore', 00:22:29 INFO - 'sessionrestore_no_auto_restore', 00:22:29 INFO - 'tabpaint']}, 00:22:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:22:29 INFO - 'ts_paint', 00:22:29 INFO - 'tpaint', 00:22:29 INFO - 'sessionrestore', 00:22:29 INFO - 'sessionrestore_no_auto_restore', 00:22:29 INFO - 'tabpaint']}, 00:22:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:22:29 INFO - 'ts_paint', 00:22:29 INFO - 'tpaint', 00:22:29 INFO - 'sessionrestore', 00:22:29 INFO - 'sessionrestore_no_auto_restore', 00:22:29 INFO - 'tabpaint']}, 00:22:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['a11yr', 00:22:29 INFO - 'ts_paint', 00:22:29 INFO - 'tpaint', 00:22:29 INFO - 'sessionrestore', 00:22:29 INFO - 'sessionrestore_no_auto_restore', 00:22:29 INFO - 'tabpaint']}, 00:22:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['a11yr', 00:22:29 INFO - 'ts_paint', 00:22:29 INFO - 'tpaint', 00:22:29 INFO - 'sessionrestore', 00:22:29 INFO - 'sessionrestore_no_auto_restore', 00:22:29 INFO - 'tabpaint']}, 00:22:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['tsvgx', 00:22:29 INFO - 'tsvgr_opacity', 00:22:29 INFO - 'tart', 00:22:29 INFO - 'tscrollx', 00:22:29 INFO - 'cart']}, 00:22:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:22:29 INFO - 'tsvgr_opacity', 00:22:29 INFO - 'tart', 00:22:29 INFO - 'tscrollx', 00:22:29 INFO - 'cart']}, 00:22:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:29 INFO - 'talos_options': ['--disable-e10s'], 00:22:29 INFO - 'tests': ['tp5o']}, 00:22:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:29 INFO - 'tests': ['tp5o']}, 00:22:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:29 INFO - 'talos_options': ['--disable-e10s', 00:22:29 INFO - '--xperf_path', 00:22:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:22:29 INFO - 'tests': ['tp5n']}, 00:22:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:29 INFO - 'talos_options': ['--xperf_path', 00:22:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:22:29 INFO - 'tests': ['tp5n']}}, 00:22:29 INFO - 'talos.zip': {'path': '', 00:22:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:22:29 INFO - Running post-action listener: _resource_record_post_action 00:22:29 INFO - [mozharness: 2016-08-02 07:22:29.393762Z] Finished populate-webroot step (success) 00:22:29 INFO - [mozharness: 2016-08-02 07:22:29.393850Z] Running create-virtualenv step. 00:22:29 INFO - Running pre-action listener: _resource_record_pre_action 00:22:29 INFO - Running main action method: create_virtualenv 00:22:29 INFO - Creating virtualenv /builds/slave/test/build/venv 00:22:29 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 00:22:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:22:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:22:29 INFO - Using real prefix '/usr' 00:22:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:22:29 INFO - Installing distribute.............................................................................................................................................................................................done. 00:22:31 INFO - Installing pip.................done. 00:22:31 INFO - Return code: 0 00:22:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:31 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 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:31 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 00:22:31 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 00:22:31 INFO - Using env: {'DISPLAY': ':0', 00:22:31 INFO - 'HOME': '/home/cltbld', 00:22:31 INFO - 'LANG': 'en_US.UTF-8', 00:22:31 INFO - 'LANGUAGE': 'en_US:en', 00:22:31 INFO - 'LOGNAME': 'cltbld', 00:22:31 INFO - 'MAIL': '/var/mail/cltbld', 00:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:31 INFO - 'MOZ_NO_REMOTE': '1', 00:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:31 INFO - 'NO_EM_RESTART': '1', 00:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:31 INFO - 'PWD': '/builds/slave/test', 00:22:31 INFO - 'SHELL': '/bin/bash', 00:22:31 INFO - 'SHLVL': '1', 00:22:31 INFO - 'TERM': 'linux', 00:22:31 INFO - 'TMOUT': '86400', 00:22:31 INFO - 'USER': 'cltbld', 00:22:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:31 INFO - '_': '/tools/buildbot/bin/python'} 00:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:32 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 00:22:32 INFO - Cleaning up... 00:22:32 INFO - Return code: 0 00:22:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:22:32 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')]} 00:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:32 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')]} 00:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:32 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 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:32 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 00:22:32 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 00:22:32 INFO - Using env: {'DISPLAY': ':0', 00:22:32 INFO - 'HOME': '/home/cltbld', 00:22:32 INFO - 'LANG': 'en_US.UTF-8', 00:22:32 INFO - 'LANGUAGE': 'en_US:en', 00:22:32 INFO - 'LOGNAME': 'cltbld', 00:22:32 INFO - 'MAIL': '/var/mail/cltbld', 00:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:32 INFO - 'MOZ_NO_REMOTE': '1', 00:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:32 INFO - 'NO_EM_RESTART': '1', 00:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:32 INFO - 'PWD': '/builds/slave/test', 00:22:32 INFO - 'SHELL': '/bin/bash', 00:22:32 INFO - 'SHLVL': '1', 00:22:32 INFO - 'TERM': 'linux', 00:22:32 INFO - 'TMOUT': '86400', 00:22:32 INFO - 'USER': 'cltbld', 00:22:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:32 INFO - '_': '/tools/buildbot/bin/python'} 00:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:32 INFO - Downloading/unpacking psutil>=3.1.1 00:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:22:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:22:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:22:34 INFO - Installing collected packages: psutil 00:22:34 INFO - Running setup.py install for psutil 00:22:34 INFO - building 'psutil._psutil_linux' extension 00:22:34 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 00:22:34 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 00:22:34 INFO - building 'psutil._psutil_posix' extension 00:22:34 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 00:22:34 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 00:22:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:22:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:22:34 INFO - Successfully installed psutil 00:22:34 INFO - Cleaning up... 00:22:34 INFO - Return code: 0 00:22:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:22:34 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')]} 00:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:34 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')]} 00:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:34 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 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:34 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 00:22:34 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 00:22:34 INFO - Using env: {'DISPLAY': ':0', 00:22:34 INFO - 'HOME': '/home/cltbld', 00:22:34 INFO - 'LANG': 'en_US.UTF-8', 00:22:34 INFO - 'LANGUAGE': 'en_US:en', 00:22:34 INFO - 'LOGNAME': 'cltbld', 00:22:34 INFO - 'MAIL': '/var/mail/cltbld', 00:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:34 INFO - 'MOZ_NO_REMOTE': '1', 00:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:34 INFO - 'NO_EM_RESTART': '1', 00:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:34 INFO - 'PWD': '/builds/slave/test', 00:22:34 INFO - 'SHELL': '/bin/bash', 00:22:34 INFO - 'SHLVL': '1', 00:22:34 INFO - 'TERM': 'linux', 00:22:34 INFO - 'TMOUT': '86400', 00:22:34 INFO - 'USER': 'cltbld', 00:22:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:34 INFO - '_': '/tools/buildbot/bin/python'} 00:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:22:35 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 00:22:35 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 00:22:35 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 00:22:35 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 00:22:35 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 00:22:35 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 00:22:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:22:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:22:37 INFO - Installing collected packages: mozsystemmonitor 00:22:37 INFO - Running setup.py install for mozsystemmonitor 00:22:37 INFO - Successfully installed mozsystemmonitor 00:22:37 INFO - Cleaning up... 00:22:37 INFO - Return code: 0 00:22:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:22:37 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')]} 00:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:37 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')]} 00:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:37 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 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:37 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 00:22:37 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 00:22:37 INFO - Using env: {'DISPLAY': ':0', 00:22:37 INFO - 'HOME': '/home/cltbld', 00:22:37 INFO - 'LANG': 'en_US.UTF-8', 00:22:37 INFO - 'LANGUAGE': 'en_US:en', 00:22:37 INFO - 'LOGNAME': 'cltbld', 00:22:37 INFO - 'MAIL': '/var/mail/cltbld', 00:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:37 INFO - 'MOZ_NO_REMOTE': '1', 00:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:37 INFO - 'NO_EM_RESTART': '1', 00:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:37 INFO - 'PWD': '/builds/slave/test', 00:22:37 INFO - 'SHELL': '/bin/bash', 00:22:37 INFO - 'SHLVL': '1', 00:22:37 INFO - 'TERM': 'linux', 00:22:37 INFO - 'TMOUT': '86400', 00:22:37 INFO - 'USER': 'cltbld', 00:22:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:37 INFO - '_': '/tools/buildbot/bin/python'} 00:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:37 INFO - Downloading/unpacking jsonschema==2.5.1 00:22:37 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 00:22:37 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 00:22:37 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 00:22:37 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 00:22:37 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 00:22:37 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 00:22:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:22:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:22:39 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 00:22:39 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 00:22:39 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 00:22:39 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 00:22:39 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 00:22:39 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 00:22:39 INFO - Downloading functools32-3.2.3-2.tar.gz 00:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:22:39 INFO - warning: no files found matching '*.txt' 00:22:39 INFO - no previously-included directories found matching 'build' 00:22:39 INFO - no previously-included directories found matching 'dist' 00:22:39 INFO - no previously-included directories found matching '.git*' 00:22:39 INFO - Installing collected packages: jsonschema, functools32 00:22:39 INFO - Running setup.py install for functools32 00:22:39 INFO - warning: no files found matching '*.txt' 00:22:39 INFO - no previously-included directories found matching 'build' 00:22:39 INFO - no previously-included directories found matching 'dist' 00:22:39 INFO - no previously-included directories found matching '.git*' 00:22:39 INFO - Successfully installed jsonschema functools32 00:22:39 INFO - Cleaning up... 00:22:39 INFO - Return code: 0 00:22:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:22:39 INFO - Using env: {'DISPLAY': ':0', 00:22:39 INFO - 'HOME': '/home/cltbld', 00:22:39 INFO - 'LANG': 'en_US.UTF-8', 00:22:39 INFO - 'LANGUAGE': 'en_US:en', 00:22:39 INFO - 'LOGNAME': 'cltbld', 00:22:39 INFO - 'MAIL': '/var/mail/cltbld', 00:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:39 INFO - 'MOZ_NO_REMOTE': '1', 00:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:39 INFO - 'NO_EM_RESTART': '1', 00:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:39 INFO - 'PWD': '/builds/slave/test', 00:22:39 INFO - 'SHELL': '/bin/bash', 00:22:39 INFO - 'SHLVL': '1', 00:22:39 INFO - 'TERM': 'linux', 00:22:39 INFO - 'TMOUT': '86400', 00:22:39 INFO - 'USER': 'cltbld', 00:22:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:39 INFO - '_': '/tools/buildbot/bin/python'} 00:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:22:39 INFO - Cleaning up... 00:22:39 INFO - Return code: 0 00:22:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:22:39 INFO - Using env: {'DISPLAY': ':0', 00:22:39 INFO - 'HOME': '/home/cltbld', 00:22:39 INFO - 'LANG': 'en_US.UTF-8', 00:22:39 INFO - 'LANGUAGE': 'en_US:en', 00:22:39 INFO - 'LOGNAME': 'cltbld', 00:22:39 INFO - 'MAIL': '/var/mail/cltbld', 00:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:39 INFO - 'MOZ_NO_REMOTE': '1', 00:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:39 INFO - 'NO_EM_RESTART': '1', 00:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:39 INFO - 'PWD': '/builds/slave/test', 00:22:39 INFO - 'SHELL': '/bin/bash', 00:22:39 INFO - 'SHLVL': '1', 00:22:39 INFO - 'TERM': 'linux', 00:22:39 INFO - 'TMOUT': '86400', 00:22:39 INFO - 'USER': 'cltbld', 00:22:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:39 INFO - '_': '/tools/buildbot/bin/python'} 00:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:40 INFO - Downloading/unpacking blobuploader==1.2.4 00:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:42 INFO - Downloading blobuploader-1.2.4.tar.gz 00:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:22:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:22:42 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 00:22:42 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 00:22:42 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 00:22:42 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 00:22:42 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 00:22:42 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 00:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:22:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:22:42 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 00:22:42 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 00:22:42 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 00:22:42 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 00:22:42 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 00:22:42 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 00:22:42 INFO - Downloading docopt-0.6.1.tar.gz 00:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:22:42 INFO - Installing collected packages: blobuploader, requests, docopt 00:22:42 INFO - Running setup.py install for blobuploader 00:22:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:22:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:22:42 INFO - Running setup.py install for requests 00:22:43 INFO - Running setup.py install for docopt 00:22:43 INFO - Successfully installed blobuploader requests docopt 00:22:43 INFO - Cleaning up... 00:22:43 INFO - Return code: 0 00:22:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:43 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 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:43 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 00:22:43 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 00:22:43 INFO - Using env: {'DISPLAY': ':0', 00:22:43 INFO - 'HOME': '/home/cltbld', 00:22:43 INFO - 'LANG': 'en_US.UTF-8', 00:22:43 INFO - 'LANGUAGE': 'en_US:en', 00:22:43 INFO - 'LOGNAME': 'cltbld', 00:22:43 INFO - 'MAIL': '/var/mail/cltbld', 00:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:43 INFO - 'MOZ_NO_REMOTE': '1', 00:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:43 INFO - 'NO_EM_RESTART': '1', 00:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:43 INFO - 'PWD': '/builds/slave/test', 00:22:43 INFO - 'SHELL': '/bin/bash', 00:22:43 INFO - 'SHLVL': '1', 00:22:43 INFO - 'TERM': 'linux', 00:22:43 INFO - 'TMOUT': '86400', 00:22:43 INFO - 'USER': 'cltbld', 00:22:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:43 INFO - '_': '/tools/buildbot/bin/python'} 00:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:22:43 INFO - Running setup.py (path:/tmp/pip-JRucXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:22:43 INFO - Running setup.py (path:/tmp/pip-Lq7qt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:22:43 INFO - Running setup.py (path:/tmp/pip-pBYE2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:22:43 INFO - Running setup.py (path:/tmp/pip-juPyy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:22:44 INFO - Running setup.py (path:/tmp/pip-VIvGls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:22:44 INFO - Running setup.py (path:/tmp/pip-1scjmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:22:44 INFO - Running setup.py (path:/tmp/pip-nnttQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:22:44 INFO - Running setup.py (path:/tmp/pip-uPpilK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:22:44 INFO - Running setup.py (path:/tmp/pip-EFdsEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:22:44 INFO - Running setup.py (path:/tmp/pip-49fEiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:22:44 INFO - Running setup.py (path:/tmp/pip-bAj_I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:22:44 INFO - Running setup.py (path:/tmp/pip-Kk_hJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:22:44 INFO - Running setup.py (path:/tmp/pip-KFnOSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:22:44 INFO - Running setup.py (path:/tmp/pip-Meh9qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:22:44 INFO - Running setup.py (path:/tmp/pip-ugzkPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:22:44 INFO - Running setup.py (path:/tmp/pip-E4xGMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:22:44 INFO - Running setup.py (path:/tmp/pip-2MNf_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:22:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:22:44 INFO - Running setup.py install for manifestparser 00:22:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:22:45 INFO - Running setup.py install for mozcrash 00:22:45 INFO - Running setup.py install for mozdebug 00:22:45 INFO - Running setup.py install for mozdevice 00:22:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:22:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:22:45 INFO - Running setup.py install for mozfile 00:22:45 INFO - Running setup.py install for mozhttpd 00:22:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:22:45 INFO - Running setup.py install for mozinfo 00:22:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:22:45 INFO - Running setup.py install for mozInstall 00:22:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:22:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:22:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:22:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:22:45 INFO - Running setup.py install for mozleak 00:22:45 INFO - Running setup.py install for mozlog 00:22:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:22:46 INFO - Running setup.py install for moznetwork 00:22:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:22:46 INFO - Running setup.py install for mozprocess 00:22:46 INFO - Running setup.py install for mozprofile 00:22:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:22:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:22:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:22:46 INFO - Running setup.py install for mozrunner 00:22:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:22:46 INFO - Running setup.py install for mozscreenshot 00:22:46 INFO - Running setup.py install for moztest 00:22:46 INFO - Running setup.py install for mozversion 00:22:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:22:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:22:46 INFO - Cleaning up... 00:22:46 INFO - Return code: 0 00:22:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:22:46 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')]} 00:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:46 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')]} 00:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:46 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 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:46 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 00:22:46 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 00:22:46 INFO - Using env: {'DISPLAY': ':0', 00:22:46 INFO - 'HOME': '/home/cltbld', 00:22:46 INFO - 'LANG': 'en_US.UTF-8', 00:22:46 INFO - 'LANGUAGE': 'en_US:en', 00:22:46 INFO - 'LOGNAME': 'cltbld', 00:22:46 INFO - 'MAIL': '/var/mail/cltbld', 00:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:46 INFO - 'MOZ_NO_REMOTE': '1', 00:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:46 INFO - 'NO_EM_RESTART': '1', 00:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:46 INFO - 'PWD': '/builds/slave/test', 00:22:46 INFO - 'SHELL': '/bin/bash', 00:22:46 INFO - 'SHLVL': '1', 00:22:46 INFO - 'TERM': 'linux', 00:22:46 INFO - 'TMOUT': '86400', 00:22:46 INFO - 'USER': 'cltbld', 00:22:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:46 INFO - '_': '/tools/buildbot/bin/python'} 00:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:22:46 INFO - Running setup.py (path:/tmp/pip-tpw71z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:22:47 INFO - Running setup.py (path:/tmp/pip-r7Wxe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:22:47 INFO - Running setup.py (path:/tmp/pip-nceanE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:22:47 INFO - Running setup.py (path:/tmp/pip-BAoPdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:22:47 INFO - Running setup.py (path:/tmp/pip-WXL188-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:22:47 INFO - Running setup.py (path:/tmp/pip-8HLp2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:22:47 INFO - Running setup.py (path:/tmp/pip-jwxtNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:22:47 INFO - Running setup.py (path:/tmp/pip-tkDRNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:22:47 INFO - Running setup.py (path:/tmp/pip-aD9qoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:22:47 INFO - Running setup.py (path:/tmp/pip-diPgFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:22:47 INFO - Running setup.py (path:/tmp/pip-mpvBFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:22:47 INFO - Running setup.py (path:/tmp/pip-oo_ZY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:22:47 INFO - Running setup.py (path:/tmp/pip-gYoyKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:22:47 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)) 00:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:22:47 INFO - Running setup.py (path:/tmp/pip-KaMZk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:22:48 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)) 00:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:22:48 INFO - Running setup.py (path:/tmp/pip-2LTB1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:22:48 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)) 00:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:22:48 INFO - Running setup.py (path:/tmp/pip-w4AmYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:22:48 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)) 00:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:22:48 INFO - Running setup.py (path:/tmp/pip-TS6Kbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:22:48 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)) 00:22:48 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)) 00:22:48 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)) 00:22:48 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)) 00:22:48 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)) 00:22:48 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)) 00:22:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:50 INFO - Downloading blessings-1.6.tar.gz 00:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:22:50 INFO - Installing collected packages: blessings 00:22:50 INFO - Running setup.py install for blessings 00:22:50 INFO - Successfully installed blessings 00:22:50 INFO - Cleaning up... 00:22:50 INFO - Return code: 0 00:22:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:22:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:22:50 INFO - Reading from file tmpfile_stdout 00:22:50 INFO - Current package versions: 00:22:50 INFO - argparse == 1.2.1 00:22:50 INFO - blessings == 1.6 00:22:50 INFO - blobuploader == 1.2.4 00:22:50 INFO - docopt == 0.6.1 00:22:50 INFO - functools32 == 3.2.3-2 00:22:50 INFO - jsonschema == 2.5.1 00:22:50 INFO - manifestparser == 1.1 00:22:50 INFO - mozInstall == 1.12 00:22:50 INFO - mozcrash == 0.17 00:22:50 INFO - mozdebug == 0.1 00:22:50 INFO - mozdevice == 0.48 00:22:50 INFO - mozfile == 1.2 00:22:50 INFO - mozhttpd == 0.7 00:22:50 INFO - mozinfo == 0.9 00:22:50 INFO - mozleak == 0.1 00:22:50 INFO - mozlog == 3.3 00:22:50 INFO - moznetwork == 0.27 00:22:50 INFO - mozprocess == 0.23 00:22:50 INFO - mozprofile == 0.28 00:22:50 INFO - mozrunner == 6.12 00:22:50 INFO - mozscreenshot == 0.1 00:22:50 INFO - mozsystemmonitor == 0.3 00:22:50 INFO - moztest == 0.7 00:22:50 INFO - mozversion == 1.4 00:22:50 INFO - psutil == 3.1.1 00:22:50 INFO - requests == 1.2.3 00:22:50 INFO - wsgiref == 0.1.2 00:22:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:22: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')]} 00:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22: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')]} 00:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:50 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 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:50 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 00:22:50 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 00:22:50 INFO - Using env: {'DISPLAY': ':0', 00:22:50 INFO - 'HOME': '/home/cltbld', 00:22:50 INFO - 'LANG': 'en_US.UTF-8', 00:22:50 INFO - 'LANGUAGE': 'en_US:en', 00:22:50 INFO - 'LOGNAME': 'cltbld', 00:22:50 INFO - 'MAIL': '/var/mail/cltbld', 00:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:50 INFO - 'MOZ_NO_REMOTE': '1', 00:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:50 INFO - 'NO_EM_RESTART': '1', 00:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:50 INFO - 'PWD': '/builds/slave/test', 00:22:50 INFO - 'SHELL': '/bin/bash', 00:22:50 INFO - 'SHLVL': '1', 00:22:50 INFO - 'TERM': 'linux', 00:22:50 INFO - 'TMOUT': '86400', 00:22:50 INFO - 'USER': 'cltbld', 00:22:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:50 INFO - '_': '/tools/buildbot/bin/python'} 00:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:50 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)) 00:22:50 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)) 00:22:50 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)) 00:22:50 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)) 00:22:50 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)) 00:22:50 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)) 00:22:50 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)) 00:22:50 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)) 00:22:50 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)) 00:22:50 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)) 00:22:50 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)) 00:22:50 INFO - Cleaning up... 00:22:50 INFO - Return code: 0 00:22:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:22: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')]} 00:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22: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')]} 00:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1402030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', '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 00:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:22:50 INFO - Using env: {'DISPLAY': ':0', 00:22:50 INFO - 'HOME': '/home/cltbld', 00:22:50 INFO - 'LANG': 'en_US.UTF-8', 00:22:50 INFO - 'LANGUAGE': 'en_US:en', 00:22:50 INFO - 'LOGNAME': 'cltbld', 00:22:50 INFO - 'MAIL': '/var/mail/cltbld', 00:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:50 INFO - 'MOZ_NO_REMOTE': '1', 00:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:50 INFO - 'NO_EM_RESTART': '1', 00:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:50 INFO - 'PWD': '/builds/slave/test', 00:22:50 INFO - 'SHELL': '/bin/bash', 00:22:50 INFO - 'SHLVL': '1', 00:22:50 INFO - 'TERM': 'linux', 00:22:50 INFO - 'TMOUT': '86400', 00:22:50 INFO - 'USER': 'cltbld', 00:22:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:50 INFO - '_': '/tools/buildbot/bin/python'} 00:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:22:51 INFO - Cleaning up... 00:22:51 INFO - Return code: 0 00:22:51 INFO - Running post-action listener: _resource_record_post_action 00:22:51 INFO - Running post-action listener: _start_resource_monitoring 00:22:51 INFO - Starting resource monitoring. 00:22:51 INFO - [mozharness: 2016-08-02 07:22:51.084368Z] Finished create-virtualenv step (success) 00:22:51 INFO - [mozharness: 2016-08-02 07:22:51.084842Z] Running install step. 00:22:51 INFO - Running pre-action listener: _resource_record_pre_action 00:22:51 INFO - Running main action method: install 00:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:22:51 INFO - Reading from file tmpfile_stdout 00:22:51 INFO - Detecting whether we're running mozinstall >=1.0... 00:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:22:51 INFO - Reading from file tmpfile_stdout 00:22:51 INFO - Output received: 00:22:51 INFO - Usage: mozinstall [options] installer 00:22:51 INFO - Options: 00:22:51 INFO - -h, --help show this help message and exit 00:22:51 INFO - -d DEST, --destination=DEST 00:22:51 INFO - Directory to install application into. [default: 00:22:51 INFO - "/builds/slave/test"] 00:22:51 INFO - --app=APP Application being installed. [default: firefox] 00:22:51 INFO - mkdir: /builds/slave/test/build/application 00:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:23:07 INFO - Reading from file tmpfile_stdout 00:23:07 INFO - Output received: 00:23:07 INFO - /builds/slave/test/build/application/firefox/firefox 00:23:07 INFO - Running post-action listener: _resource_record_post_action 00:23:07 INFO - [mozharness: 2016-08-02 07:23:07.439390Z] Finished install step (success) 00:23:07 INFO - [mozharness: 2016-08-02 07:23:07.439635Z] Running run-tests step. 00:23:07 INFO - Running pre-action listener: _resource_record_pre_action 00:23:07 INFO - Running main action method: run_tests 00:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:23:07 INFO - Python 2.7.3 00:23:07 INFO - Return code: 0 00:23:07 INFO - grabbing minidump binary from tooltool 00:23: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')]} 00:23:07 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 0x16c13b0>, '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 0x16c22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:23:07 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 00:23:07 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 00:23:07 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 00:23:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:23:07 INFO - Return code: 0 00:23:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:23:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:23:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:23:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:23:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:23:07 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/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 00:23:07 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/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 00:23:07 INFO - Using env: {'DISPLAY': ':0', 00:23:07 INFO - 'HOME': '/home/cltbld', 00:23:07 INFO - 'LANG': 'en_US.UTF-8', 00:23:07 INFO - 'LANGUAGE': 'en_US:en', 00:23:07 INFO - 'LOGNAME': 'cltbld', 00:23:07 INFO - 'MAIL': '/var/mail/cltbld', 00:23:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:23:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:07 INFO - 'MOZ_NO_REMOTE': '1', 00:23:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:23:07 INFO - 'NO_EM_RESTART': '1', 00:23:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:07 INFO - 'PWD': '/builds/slave/test', 00:23:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:23:07 INFO - 'SHELL': '/bin/bash', 00:23:07 INFO - 'SHLVL': '1', 00:23:07 INFO - 'TERM': 'linux', 00:23:07 INFO - 'TMOUT': '86400', 00:23:07 INFO - 'USER': 'cltbld', 00:23:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091', 00:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:07 INFO - '_': '/tools/buildbot/bin/python'} 00:23:07 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/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 00:23:07 INFO - mozversion application_buildid: 20160801234249 00:23:07 INFO - mozversion application_changeset: a8e4a7ff0197fa9f9d77113ce31742641e71782a 00:23:07 INFO - mozversion application_display_name: Nightly 00:23:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:23:07 INFO - mozversion application_name: Firefox 00:23:07 INFO - mozversion application_remotingname: firefox 00:23:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:23:07 INFO - mozversion application_vendor: Mozilla 00:23:07 INFO - mozversion application_version: 51.0a1 00:23:07 INFO - mozversion platform_buildid: 20160801234249 00:23:07 INFO - mozversion platform_changeset: a8e4a7ff0197fa9f9d77113ce31742641e71782a 00:23:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:23:07 INFO - mozversion platform_version: 51.0a1 00:23:07 INFO - using testdate: 1470122587 00:23:07 INFO - actual date: 1470122587 00:23:07 INFO - starting webserver on 'localhost:59304' 00:23:07 INFO - SUITE-START | Running 2 tests 00:23:07 INFO - TEST-START | dromaeo_css 00:23:07 INFO - operating with platform_type : linux_ 00:23:07 INFO - Initialising browser for dromaeo_css test... 00:23:07 INFO - TEST-INFO | started process 11244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpshXbQT/profile http://localhost:59304/getInfo.html) 00:23:12 INFO - PROCESS | 11244 | __metrics Screen width/height:1600/1200 00:23:12 INFO - PROCESS | 11244 | colorDepth:24 00:23:12 INFO - PROCESS | 11244 | Browser inner width/height: 1024/697 00:23:12 INFO - PROCESS | 11244 | __metrics 00:23:12 INFO - PROCESS | 11244 | 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" 00:23:12 INFO - PROCESS | 11244 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:23:13 INFO - PROCESS | 11244 | console.error: PushService: 00:23:13 INFO - PROCESS | 11244 | stateChangeProcessEnqueue: Error transitioning state 00:23:13 INFO - PROCESS | 11244 | UnknownError 00:23:13 INFO - TEST-INFO | 11244: exit 0 00:23:13 INFO - Browser initialized. 00:23:13 INFO - Running cycle 1/1 for dromaeo_css test... 00:23:13 INFO - TEST-INFO | started process 11322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpshXbQT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:23:25 INFO - PROCESS | 11322 | RSS: Main: 158089216 00:23:25 INFO - PROCESS | 11322 | 00:24:16 INFO - PROCESS | 11322 | 1470122656607 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] 00:26:29 INFO - PROCESS | 11322 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59304/tests/dromaeo/cssquery-ext.html) 00:26:30 INFO - PROCESS | 11322 | RSS: Main: 281612288 00:26:30 INFO - PROCESS | 11322 | 00:29:33 INFO - PROCESS | 11322 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-ext.html (next: http://localhost:59304/tests/dromaeo/cssquery-jquery.html) 00:29:34 INFO - PROCESS | 11322 | RSS: Main: 242925568 00:29:34 INFO - PROCESS | 11322 | 00:32:36 INFO - PROCESS | 11322 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59304/tests/dromaeo/cssquery-mootools.html) 00:32:36 INFO - PROCESS | 11322 | RSS: Main: 188100608 00:32:36 INFO - PROCESS | 11322 | 00:35:39 INFO - PROCESS | 11322 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59304/tests/dromaeo/cssquery-prototype.html) 00:35:39 INFO - PROCESS | 11322 | RSS: Main: 187981824 00:35:39 INFO - PROCESS | 11322 | 00:38:42 INFO - PROCESS | 11322 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59304/tests/dromaeo/cssquery-yui.html) 00:38:43 INFO - PROCESS | 11322 | RSS: Main: 189153280 00:38:43 INFO - PROCESS | 11322 | 00:41:46 INFO - PROCESS | 11322 | Cycle 1(1): loaded http://localhost:59304/tests/dromaeo/cssquery-yui.html (next: http://localhost:59304/tests/dromaeo/cssquery-dojo.html) 00:41:46 INFO - PROCESS | 11322 | RSS: Main: 278163456 00:41:46 INFO - PROCESS | 11322 | 00:41:46 INFO - PROCESS | 11322 | __start_tp_report 00:41:46 INFO - PROCESS | 11322 | _x_x_mozilla_page_load 00:41:46 INFO - PROCESS | 11322 | _x_x_mozilla_page_load_details 00:41:46 INFO - PROCESS | 11322 | |i|pagename|runs| 00:41:46 INFO - PROCESS | 11322 | |0;dojo.html;2611.647427597274;2635.4202075543376;2645.6163856240846;2650.3639126609605;2660.5876089206167;4577.992841574856;4668.486466488684;4730.1012807566585;4753.405824271966;4764.380630518032;4663.790129444174;4690.273007683806;4717.410323709528;4732.716037037781;4797.0885531748945;4336.241157797389;4348.6521078313735;4435.911281774363;4441.444819397575;4456.175607512604;4362.825486980517;4424.181526417607;4443.37792709021;4461.286194208928;4505.481869585007;4412;4452.866414007585;4466.196084704752;4470.351798989144;4470.396496472983;4244.893877653083;4300.74195548265;4362.541933097043;4411.228035093845;4412.294032954712;4287.592678695519;4289.270823959934;4289.892752681177;4300.8709738707885;4329.696921215516;4737.573618374363;4752.619790416758;4776.593989510896;4804.399450068741;4823.204171311764;4919.163742163841;5082.872928176826;5107.106256405114;5110.744462776884;5157.742112894341;5030.823921162779;5065.392152941634;5124.641275110744;5141.485851414866;5184.7407629618365;4797.904041919142;4808.735519546389;4824.8793780155775;4827.927581086286;4832.178529649968;5012.573931215815;5169.71566563835;5275.815346462856;5294.655847369909;5297.417284098746;5003.024410239968;5052.747362631853;5078.3905931287745;5090.338256026767;5096.490350964874;5119.180931051014;5124.9510457616725;5138.306328645585;5139.743012849417;5171.818986335536;4892.119418504703;4960.851174464772;5051.520105590037;5061.822836200715;5065.442801291855;4961.627877909171;5017.8243761468175;5022.84931452057;5072.898542029138;5093.0577843099145;4220.725652832618;4233.322668373107;4239.04621460169;4239.59723826236;4278.893027674333;3767.660910518012;3780.546334439885;3782.0355809268463;3782.8486860525272;3787.3750831113107;4286.507051689034;4378.0806030733265;4436.778161091933;4437.667174961891;4494.865154045384;5125.256837758504;5147.253648220987;5149.819756308586;5149.845504634867;5191.6884986900905;4440.844570440084;4447.066116115652;4450.955490445119;4456.888577785581;4503.076869241798;4355.956440435619;4425.778711064434;4466.531014243457;4471.083427897273;4537.047220083753;4784.545468180518;4796.232602783468;4800.543948324904;4810.086083644096;4856.587190088882;5066.493350664904;5070.771815268248;5078.111330517071;5078.289039534394;5127.051495473349;4656.557627025427;4790.137775200497;4835.854924352275;4849.515048495122;4929.112759703288;5036.874078148076;5082.517160869711;5089.592832573311;5091.0581542414775;5141.53726164647;5137.229415587692;5147.202183661539;5149.639525233198;5150.562202212854;5150.639455238097;4827.806887724451;4892.608591312757;4931.852044438672;4948.604111671129;5001.474845141353;4964.205727083649;4972.129877271535;4973.179425394769;4973.850784476472;4999.525045120708;4888.388951381077;4890.584300334512;4900.338454308623;4903.313536104877;4930.728809915489;4792.904141917073;4845.466998630078;4847.345608342828;4895.926561101657;4915.164422048332;4820.132376172322;4829.154897892925;4875.3174555562955;4899.657024008286;4961.181405068123 00:41:46 INFO - PROCESS | 11322 | |1;ext.html;558.7513556467372;565.2623326558839;577.7140315543807;589.5548860610238;592.0615823919088;29245.707542924563;39317.606823931754;40793.796031019876;40871.795641021825;44787.552124478745;40859.38710919338;41146.38280425796;41182.17635647285;41194.7940260299;41203;7390.224026477224;7637.73267935621;7773.650185741655;7777.066751989769;7784.455088143804;9847.16299114576;10127.392356458637;10155;10467.685969420929;10469.84295235572;10087.848682269736;10173.745656358577;10195.031472010147;10198.082172604463;10201.234907381939;7474.738384156529;9805.607775688964;9994.90005099947;9999.200063994864;10042.9497852511;9721.368111072758;10089.596416143419;10093.444860532667;10099.192064634812;10107.444090575016;38056.80971595124;38376.61623383759;38382.80808595939;38385.16148385167;38393.232135357415;3003.7747168962196;3050.391959500007;3106.9533956990663;3168.8732450701946;3303.223742420529;29684.70315296841;29709.257268568243;30331.393372132654;30955.845220773754;31380.529292060637;3211.775175737699;3232.7252183564424;3279.5736554247796;3389.6440873708398;3404.063882432326;253178;255527;255791;256010;256133;31488.212794679857;54992.72503637536;55268.44731552713;55369;55370.44629553734;33562.83218583892;33724.49413258803;33732;33735.83132084373;33817;13534.18794872291;13688.315584220749;13692.383842727102;13695.794563081561;13708.725825483434;9415.905840941503;11526;11609.535618575163;11744.530218791153;11852.644420667393;7873.055233372032;7885.44801863864;7887.881681774778;7956.403269754792;7968.60156992148;3127.890523831655;3156.352947645727;3163.4463968805367;3166.4617015107488;3185.394774992744;856.8072183758604;903.4985583001497;976.1556253840519;986.4328011393334;995.7411073121041;27911.325320480835;29056.7094329054;29461.55807662887;29490.262743431158;29636;939.2043512505338;970.6069042037985;1023.2888142740724;1035.8601588785568;1046.8639076920103;15214.163221022729;15251.389944402099;15301;15384.230788460532;15609.453669121527;394531;395385;397409;398796;399114;50588.241176382384;51005.489945100075;51258;51259;51415.48584514182;1072.2922870905165;1123.1239633086207;1126.6169502369235;1187.4597058338436;1196.485511230162;23597.646035309142;28687.569686454302;29886.85056574703;30389.848050759603;31196;46231.30653040274;52189.7390513045;52198.21702674539;52228.47771522236;52235.216471752196;367076;369260;370763;370772;371911;30948.381032378777;34509.827450862584;34665.48001779925;40685.79657101695;41769.16461670689;38996.415053774785;42421.575784242996;43130;43217.35173972456;43477.13045739131;36077.27845443024;37374.252514950094;37641.05897352588;37799.433008505446;39079;37148.81425592963;37636.24727505489;38449.23101538009;38858.80570597129;38951.61048389593;36936.815315923246;37145.25709485849;37239.25521489609;37824.24351512899;38075;32544.186395340304;34794;35038.12404689903;35311;35479.64520354763;26131.216063518124;26369.736302636727;26538.86730566335;26540.469190615695;26615.733842661324 00:41:46 INFO - PROCESS | 11322 | |2;jquery.html;362.53776435045313;363.53830635093425;368.86167687117313;379.886034189743;386.5496696348754;16001;16950;17649.117544122808;17765.7335139973;17765.7335139973;16780;17443.127843607832;17605.207765650546;17698.646027079452;17718.82281177191;5051.823186188475;5309.389420216667;5310.362756469229;5313.415524292324;5314.335708036496;3575.3921833288273;3677.5219221501166;3710.5361829771277;5241.554467870235;5445.428230035829;6323.9051414228825;6332.683365831713;6336.778212762554;6337.461315788163;6338.144350512691;6060.3939606039485;6172.876542469148;6197.287311959138;6200.069989501566;6323.77866774663;5467.863303417406;5469.124940009619;5470.124780035176;5472.480114389126;5473.644213126134;12108.21296615726;15858.36566537337;20077.397678069683;20920.895395523075;21081.789182108136;1922.404054743034;1972.7336809530673;2037.0481266343247;2341.555104530134;2362.5511152881068;8692.391532592721;9404.764880878032;9594.088561586637;12456.377181140997;12665.556705515262;1639.3934244329555;1660.7093758592318;1714.9314027438888;1761.0930370859019;1808.2495764257817;62965;67605.66197168983;67860.32139678638;68702.65648671724;68903;8135.3491720662205;8565.914340856512;8682.6092825823;8696.565171741388;9763.658271960447;11335.376554289593;11405;11412.600558980395;11413.543458261576;11414.258073225214;6748.4938629602975;6896.689648965808;6988.755393561302;7046.401055910203;7051.29487051301;6904.067950826574;6979.651017449107;7118.359347658736;7125.75059872902;7156.069710937545;3516.4373700207843;3613.2231570212007;3621.3119507294055;3672.9899277698314;3715.256948610289;1694.4831826292852;1721.8966861988322;1749.3964582219114;1776.7512548243255;1809.2943751936755;794.7417089445953;806.3629732511367;829.9751007469665;844.2317491083207;884.5488800711684;16502.954779673382;16605.83394166043;17345.13274336278;17723.11384430799;17991.190396432194;805.5569436809732;846.6697987784769;851.8764779107119;857.3398483167925;867.9522626255616;9112.95443522778;9574.760630984281;9821.116099551075;9867.512150517283;9906.157976571927;377260;403151;403899;404476;406035;79516.6024169887;79546.6022669883;79790;80669;80688;894.494610545027;905.4160066756905;914.1772404835568;923.7782932096248;926.7312479380904;15140.621484462976;15314.770278445609;15601.921990390429;15725.292361843973;15960.920195398949;33070.50394244136;38223;38647.80676096714;38948.2210355797;39620.00949976274;52209.21686174787;52501.21248181204;53567.73216133894;53659.73170134125;53899.73050134881;6447.3552644735155;6699.129113215251;7138;7388.6675099621725;7623.9618801905635;10292.845607316047;11812.586559470377;11840.407979600814;11887.108466865193;12166.148369614042;9848.950755246178;10384.32501887375;10429.895701042893;10462.947685261524;10479.42363170033;9885.50572471388;10163.390196588229;10193.643222487177;10230.539625716712;10505.632302869362;9961.900380996098;10121.240906931862;10123;10159.238057145596;10742.51658675377;6669.333066693292;6822.488313376417;6949.3745562899585;6965.860682786215;7008.474364422586;7535.6985720570565;10411.47942602882;10465.64116809615;10496.580136794748;10807.783844323227 00:41:46 INFO - PROCESS | 11322 | |3;mootools.html;1233.827264183014;1307.856135825059;1375.807386965825;1408.3169662713583;1608.3807734022398;6348.968255158724;7006.404455621272;7280.708771649128;7281.199068102511;7512.248775122485;7351.963240183792;7387.630618469068;7395.667194976226;7399.963000185005;7403.185649578542;2129.2760461443145;2162.50262439639;2164.4588852786806;2164.5238047629573;2165.7076294700173;2100.170432679091;2137.3908436095717;2169.511859831541;2170.8371872109574;2172.2722887832597;2118.0998075817793;2140.2616097446357;2143.528423746781;2156.169874598283;2157.5361297321074;2051.6101940631306;2053.3429302623167;2057.1565658080267;2059.3718915730697;2065.989670051655;2053.3121404329568;2110.778368271325;2120.777318381563;2121.4060063182333;2136.978630213709;7218.530795498275;7395.4083673306;7402.444816638774;7409.407247420193;7460.03019607453;4237.512686041114;4447.088346888912;4457.086297309044;4470;4472.552744725534;2901.956470652942;3001.1296723950027;3034.78756487046;3063.9693603063906;3064.387122575494;906.9229115525188;914.3964983111115;928.3826255540058;935.2471260635186;937.8358787212279;9479;9520.666776662783;9528.094830991045;9550.95224523873;9567.712968610884;3779.149691319431;3844;3916.9020774480864;3919.666828319625;3996.320625493673;7735.806604834924;7785.571793551296;7786.4938778979185;7788.065432148179;7790.026246719161;4360.236958532308;4382.671299652538;4384.934225986613;4392.3191905254735;4395.912081758411;3421.0934102462866;3963.58382369847;4036.6770658347264;4056.5740597236863;4124.876253712393;3322.6511216321937;3324.9335013299597;3431.897043088711;3440.4323286657423;3440.82795860206;1023.2632504596678;1035.8239099352977;1039.5789705169418;1056.984145237822;1061.363182090755;844.5270648436895;868.769776009358;872.6858331000834;907.0249481807084;908.0329449136781;5221.686698798084;5230.189320655304;5251.059406732242;5385.165299378603;5386.434424385383;848.2154007542998;860.3246451535515;879.683314006957;880.2693764175718;884.920357167845;3467.8439470223902;3648.835802388899;3669.486271921933;3745.606711295329;3864.2851072551107;8531.189536993976;8745.212930836255;8918.73243802674;8954.955225223832;8960.820783584291;8928.910710892938;8929.419587726778;8929.955350223338;8946.150115738994;8953.641854325884;7016.473764467583;7021.613811240329;7093.680784364613;7105.147382314155;7111.96444017787;5114.616403769806;5219.582433405242;5230;5282.603804714585;5304.867378315419;8520.423721611522;8668.566571671518;8684.04475507681;8721.825563488568;8788;8556.144385561644;8773.517456539952;8791.296696264411;8792.120787921156;8832.337574681796;5726.427357264407;6464.22429308486;6565.540412171103;6734.56225345351;6738.056672066013;7169.068021157216;7355.632218388952;7395.482316237812;7410.6665200065045;7427.034485517064;6424.261209960728;6564.4748420127235;6616.801495955129;6681.432078273207;6689.297623749436;6179.28938172116;6317.6209427434505;6359.4276515112015;6422.133012043501;6444.548881578245;6146.907796383147;6273.215848018997;6274.843128921813;6280.434760871543;6287.2769631492965;4376.234159022222;4461.977690111528;4536.56902594253;4540.841070562515;4628.907421851477;3690.5940346562393;3798.772073675588;3859.826307816099;3884.4561761354;3960.386140148282 00:41:46 INFO - PROCESS | 11322 | |4;prototype.html;289.7899023208174;295.2132566709718;297.4155783884666;301.0862033727637;301.942630900129;4739;4778.4504781950045;4792.376990991171;4816.397950256218;4859.392575928009;4778.569928706415;4796.129509491301;4804.159272127373;4840.322354870321;4867.68360056597;3579.158897659048;3703.7222208334347;3735.4583585380237;3807.2575847709777;3823.2162406706557;3387.8644854205804;3731.794751288678;3741.625837416264;3747.4191500317493;3763.1721021375392;3733.439984002408;3740.9812950935343;3741.681957033655;3756.492873462075;3765.868194613189;3736.327461057009;3750.362438385467;3756.7370284080125;3760.793156376398;3775.9433608495897;3162.130414136108;3207.5990501187352;3311.9503207451908;3316.93366132676;3324.9168770780684;4663.137319595886;4672.696274742131;4673.135469938038;4682.953170468286;4683.62778799264;4293.355996600504;4307.763073030982;4332.696711230215;4336.7831608419765;4356.8257269709175;4754.738489383082;4973;5018.949810501885;5047.268146118829;5057.747112644353;3548.787072775616;3555.306715190539;3566.715982246389;3569.303985722785;3573.3746594345885;4985.227289770055;5143.922841157349;5203.973980130075;5257.553107985787;5261.84264451573;3541.8760343387858;3571.607123216444;3578.982105089458;3605.6935160511125;3674.375356189454;3700.315441643251;3711.554613446404;3719.6652301293016;3720.776753394805;3723.515942927402;4231.217224813419;4237.453329534697;4249.277622804131;4250.362445633118;4265.957340426556;4782.689125206851;5002.549770520671;5034.521720436553;5050.696958182521;5070.569001634829;1297.8312819333426;1299.4152631315756;1301.6160232731368;1308.1693124865778;1312.3241530611742;798.856205882935;829.7676650537859;840.2689659995842;843.700486327345;851.9105493923173;4064.1871625674985;4065.57311482296;4067.5525692173837;4068.898277543026;4090.7136500444685;4607.608353289941;4628.074385122989;4629.800844598856;4653.7207767534055;4668.5798278155125;4069.328560787437;4088.814243869245;4116.197341518435;4125.66994640428;4136.6483848872585;2466.79032282258;2567.242663414297;2774.8196367236064;2787.7212278771963;2800.705925877794;4938.530839570235;4950.653454258168;4956.951474842946;4973.73169841688;4982.975085124551;5209.762816066372;5375.220593014069;5380.757865896044;5392.191171324254;5416.945830541644;4898.853034408973;4928.359313289249;4949.851504454872;4955.975220123948;4956.141446957391;5217.269582258563;5232.712200828991;5237.2667826505085;5239.345081864767;5283.1546952487415;4851.975740121418;5080.847574572768;5105.361829771278;5116.130257856248;5158.6131040171385;4710.152172608826;4771.856844294677;4928.581070608895;4932.383452068491;4968.826091086795;3611.2777444510675;3640.7997560133385;3655.6527129922615;3656.8902932912056;3682.797446140488;5274.393444753749;5277.4194838566955;5296.814611488733;5302.893942121059;5305.389880163831;5008.524190201925;5076;5161.948380516147;5161.948380516147;5176.094183517794;5047.520485553867;5063.215201643751;5076.441591424867;5079.136546787129;5082.745862706776;4994.850154495371;5004.899902002013;5010.39667306473;5076.695398276115;5084.3644544431945;4839.491853355347;5079.492050795039;5130.204818253177;5158.948410515847;5160.329157209539;4976.850694479172;4980.132450331126;4990.581451705593;4992.8751781205765;4998.075740839876 00:41:46 INFO - PROCESS | 11322 | |5;yui.html;650.8665723526676;708.861771954469;734.1813877526556;749.0599297881162;750.5346685055266;12696.61910142695;13653.726925461484;13714.24571648559;13744.312784360767;13768.518101866437;12846.03654725897;13066.869331306683;13201.207927524356;13315.933420332909;13359.732805343912;753.3257734327759;771.8880762289465;772.4013889235831;773.3233420756837;773.3812949640294;626.6208943589131;747.0773594610652;768.6387397922967;773.1997382708897;779.7894568466511;812;816.0207750699155;818.7175424478545;818.8935438393;819.1030821250721;817.2277198047847;819.1153554161491;819.5983967855767;819.663937785511;820.5363969357294;477.0911413756799;576.6223123853882;591.8905002574537;592.0497601349857;598.9610675306092;12500.187487813353;12532.310722910237;12537.185082969578;12537.56118535856;12542.435590398454;11898.345590992492;12624.558140465131;12688.936555317165;12704.555340563129;13367.933160334233;11387.430628468626;11514.481848316846;11566.42167891602;11651.883481165249;11775.882241177564;3989.6209860063245;4000.399940008993;4034.7895631310785;4175.373693945902;4177.10192308652;65775.67112164457;66271.66864165648;67340.3265967339;67350.66324668394;68594;9390.718278451657;9586.233101351874;9933.65232216869;9966.501674916226;9980.301378903407;18001.279948802163;18289.7256541152;18297.908510457364;18301.816981830012;18304.084795760424;6451.9354806452275;6507.1540699709685;6629.337066293332;6654.6672666366485;6948.200956889921;3761.191343861083;3841.4045822897497;3850.1144736710153;3881.941770873439;3885.2229554089295;2710.1733971138597;2759.300075127004;2783.916482505528;2826.6042754014456;2832.929176770597;505.2724077328635;513.0969493691131;517.4644243208337;519.2833889232835;523.0611053159588;419.4253872195112;482.5753337063432;525.8037963632767;527.3592585009233;565.913446183329;7315.341619254186;7359.558426494427;7498.812529686801;7538.472306938462;7998.5600791957;548.6680558262274;555.4112640600976;603.7554790309931;607.9726412311456;628.0359647940389;3528.1532432216595;3657.817109144532;3760.4547340636;3867.2652196082654;3957.604239576019;98360.50819745855;100695.49652251838;103240;103543.4822825881;103594.48202758937;52484.47515524872;52735.20897186468;52895.47104528982;53080.734596327544;79151;48573.757131214115;77740.28246469192;77937;78215;80402.59798700969;7191.460640451883;7282.162551306667;7335.486515943832;7413.518121322097;7456.02494278146;46469.76765116153;46751.29873051839;47931.281030783866;48021.27968080551;48163.5183648159;39131.60868391394;39492;39557.80221098876;40646.1870762589;41857;10071.697849064247;10170.644027459004;10229.795404092025;10276.332038417479;10488.475576221006;11329.610827420569;11356.602518911799;11411.144164187885;11426.428678566204;11556.075513959031;10246.436445995541;10485.895141048797;10594.417307048187;10701.250912436055;11015.83476247841;10474.109700675528;10606.734831629272;10638.361698298128;10782.245242832927;10902.073323767569;9712.854307185538;10115.14021308197;10356.067953884187;10603.151747860307;10937.398443085707;8303.667853286042;8527.48835069873;8692.174243446863;9126.45241285525;9212.216961558343;7737.497062690907;7877.684892604461;8605.440646357967;8855.203031727175;8924.732258032269 00:41:46 INFO - PROCESS | 11322 | __end_tp_report 00:41:46 INFO - PROCESS | 11322 | __start_cc_report 00:41:46 INFO - PROCESS | 11322 | _x_x_mozilla_cycle_collect,1228 00:41:46 INFO - PROCESS | 11322 | __end_cc_report 00:41:46 INFO - PROCESS | 11322 | __startTimestamp1470123706702__endTimestamp 00:41:46 INFO - PROCESS | 11322 | 00:41:46 INFO - PROCESS | 11322 | ------- Summary: start ------- 00:41:46 INFO - PROCESS | 11322 | Number of tests: 6 00:41:46 INFO - PROCESS | 11322 | 00:41:46 INFO - PROCESS | 11322 | [#0] dojo.html Cycles:165 Average:4703.30 Median:4827.93 stddev:498.47 (10.3%) stddev-sans-first:472.22 00:41:46 INFO - PROCESS | 11322 | Values: 2611.6 2635.4 2645.6 2650.4 2660.6 4578.0 4668.5 4730.1 4753.4 4764.4 4663.8 4690.3 4717.4 4732.7 4797.1 4336.2 4348.7 4435.9 4441.4 4456.2 4362.8 4424.2 4443.4 4461.3 4505.5 4412.0 4452.9 4466.2 4470.4 4470.4 4244.9 4300.7 4362.5 4411.2 4412.3 4287.6 4289.3 4289.9 4300.9 4329.7 4737.6 4752.6 4776.6 4804.4 4823.2 4919.2 5082.9 5107.1 5110.7 5157.7 5030.8 5065.4 5124.6 5141.5 5184.7 4797.9 4808.7 4824.9 4827.9 4832.2 5012.6 5169.7 5275.8 5294.7 5297.4 5003.0 5052.7 5078.4 5090.3 5096.5 5119.2 5125.0 5138.3 5139.7 5171.8 4892.1 4960.9 5051.5 5061.8 5065.4 4961.6 5017.8 5022.8 5072.9 5093.1 4220.7 4233.3 4239.0 4239.6 4278.9 3767.7 3780.5 3782.0 3782.8 3787.4 4286.5 4378.1 4436.8 4437.7 4494.9 5125.3 5147.3 5149.8 5149.8 5191.7 4440.8 4447.1 4451.0 4456.9 4503.1 4356.0 4425.8 4466.5 4471.1 4537.0 4784.5 4796.2 4800.5 4810.1 4856.6 5066.5 5070.8 5078.1 5078.3 5127.1 4656.6 4790.1 4835.9 4849.5 4929.1 5036.9 5082.5 5089.6 5091.1 5141.5 5137.2 5147.2 5149.6 5150.6 5150.6 4827.8 4892.6 4931.9 4948.6 5001.5 4964.2 4972.1 4973.2 4973.9 4999.5 4888.4 4890.6 4900.3 4903.3 4930.7 4792.9 4845.5 4847.3 4895.9 4915.2 4820.1 4829.2 4875.3 4899.7 4961.2 00:41:46 INFO - PROCESS | 11322 | 00:41:46 INFO - PROCESS | 11322 | [#1] ext.html Cycles:180 Average:49372.82 Median:35778.46 stddev:91341.26 (255.3%) stddev-sans-first:91523.97 00:41:46 INFO - PROCESS | 11322 | Values: 558.8 565.3 577.7 589.6 592.1 29245.7 39317.6 40793.8 40871.8 44787.6 40859.4 41146.4 41182.2 41194.8 41203.0 7390.2 7637.7 7773.7 7777.1 7784.5 9847.2 10127.4 10155.0 10467.7 10469.8 10087.8 10173.7 10195.0 10198.1 10201.2 7474.7 9805.6 9994.9 9999.2 10042.9 9721.4 10089.6 10093.4 10099.2 10107.4 38056.8 38376.6 38382.8 38385.2 38393.2 3003.8 3050.4 3107.0 3168.9 3303.2 29684.7 29709.3 30331.4 30955.8 31380.5 3211.8 3232.7 3279.6 3389.6 3404.1 253178.0 255527.0 255791.0 256010.0 256133.0 31488.2 54992.7 55268.4 55369.0 55370.4 33562.8 33724.5 33732.0 33735.8 33817.0 13534.2 13688.3 13692.4 13695.8 13708.7 9415.9 11526.0 11609.5 11744.5 11852.6 7873.1 7885.4 7887.9 7956.4 7968.6 3127.9 3156.4 3163.4 3166.5 3185.4 856.8 903.5 976.2 986.4 995.7 27911.3 29056.7 29461.6 29490.3 29636.0 939.2 970.6 1023.3 1035.9 1046.9 15214.2 15251.4 15301.0 15384.2 15609.5 394531.0 395385.0 397409.0 398796.0 399114.0 50588.2 51005.5 51258.0 51259.0 51415.5 1072.3 1123.1 1126.6 1187.5 1196.5 23597.6 28687.6 29886.9 30389.8 31196.0 46231.3 52189.7 52198.2 52228.5 52235.2 367076.0 369260.0 370763.0 370772.0 371911.0 30948.4 34509.8 34665.5 40685.8 41769.2 38996.4 42421.6 43130.0 43217.4 43477.1 36077.3 37374.3 37641.1 37799.4 39079.0 37148.8 37636.2 38449.2 38858.8 38951.6 36936.8 37145.3 37239.3 37824.2 38075.0 32544.2 34794.0 35038.1 35311.0 35479.6 26131.2 26369.7 26538.9 26540.5 26615.7 00:41:46 INFO - PROCESS | 11322 | 00:41:46 INFO - PROCESS | 11322 | [#2] jquery.html Cycles:180 Average:24525.90 Median:205543.41 stddev:65935.29 (32.1%) stddev-sans-first:66095.30 00:41:46 INFO - PROCESS | 11322 | Values: 362.5 363.5 368.9 379.9 386.5 16001.0 16950.0 17649.1 17765.7 17765.7 16780.0 17443.1 17605.2 17698.6 17718.8 5051.8 5309.4 5310.4 5313.4 5314.3 3575.4 3677.5 3710.5 5241.6 5445.4 6323.9 6332.7 6336.8 6337.5 6338.1 6060.4 6172.9 6197.3 6200.1 6323.8 5467.9 5469.1 5470.1 5472.5 5473.6 12108.2 15858.4 20077.4 20920.9 21081.8 1922.4 1972.7 2037.0 2341.6 2362.6 8692.4 9404.8 9594.1 12456.4 12665.6 1639.4 1660.7 1714.9 1761.1 1808.2 62965.0 67605.7 67860.3 68702.7 68903.0 8135.3 8565.9 8682.6 8696.6 9763.7 11335.4 11405.0 11412.6 11413.5 11414.3 6748.5 6896.7 6988.8 7046.4 7051.3 6904.1 6979.7 7118.4 7125.8 7156.1 3516.4 3613.2 3621.3 3673.0 3715.3 1694.5 1721.9 1749.4 1776.8 1809.3 794.7 806.4 830.0 844.2 884.5 16503.0 16605.8 17345.1 17723.1 17991.2 805.6 846.7 851.9 857.3 868.0 9113.0 9574.8 9821.1 9867.5 9906.2 377260.0 403151.0 403899.0 404476.0 406035.0 79516.6 79546.6 79790.0 80669.0 80688.0 894.5 905.4 914.2 923.8 926.7 15140.6 15314.8 15601.9 15725.3 15960.9 33070.5 38223.0 38647.8 38948.2 39620.0 52209.2 52501.2 53567.7 53659.7 53899.7 6447.4 6699.1 7138.0 7388.7 7624.0 10292.8 11812.6 11840.4 11887.1 12166.1 9849.0 10384.3 10429.9 10462.9 10479.4 9885.5 10163.4 10193.6 10230.5 10505.6 9961.9 10121.2 10123.0 10159.2 10742.5 6669.3 6822.5 6949.4 6965.9 7008.5 7535.7 10411.5 10465.6 10496.6 10807.8 00:41:46 INFO - PROCESS | 11322 | 00:41:46 INFO - PROCESS | 11322 | [#3] mootools.html Cycles:180 Average:4880.39 Median:5936.67 stddev:2660.01 (44.8%) stddev-sans-first:2653.35 00:41:46 INFO - PROCESS | 11322 | Values: 1233.8 1307.9 1375.8 1408.3 1608.4 6349.0 7006.4 7280.7 7281.2 7512.2 7352.0 7387.6 7395.7 7400.0 7403.2 2129.3 2162.5 2164.5 2164.5 2165.7 2100.2 2137.4 2169.5 2170.8 2172.3 2118.1 2140.3 2143.5 2156.2 2157.5 2051.6 2053.3 2057.2 2059.4 2066.0 2053.3 2110.8 2120.8 2121.4 2137.0 7218.5 7395.4 7402.4 7409.4 7460.0 4237.5 4447.1 4457.1 4470.0 4472.6 2902.0 3001.1 3034.8 3064.0 3064.4 906.9 914.4 928.4 935.2 937.8 9479.0 9520.7 9528.1 9551.0 9567.7 3779.1 3844.0 3916.9 3919.7 3996.3 7735.8 7785.6 7786.5 7788.1 7790.0 4360.2 4382.7 4384.9 4392.3 4395.9 3421.1 3963.6 4036.7 4056.6 4124.9 3322.7 3324.9 3431.9 3440.4 3440.8 1023.3 1035.8 1039.6 1057.0 1061.4 844.5 868.8 872.7 907.0 908.0 5221.7 5230.2 5251.1 5385.2 5386.4 848.2 860.3 879.7 880.3 884.9 3467.8 3648.8 3669.5 3745.6 3864.3 8531.2 8745.2 8918.7 8955.0 8960.8 8928.9 8929.4 8930.0 8946.2 8953.6 7016.5 7021.6 7093.7 7105.1 7112.0 5114.6 5219.6 5230.0 5282.6 5304.9 8520.4 8668.6 8684.0 8721.8 8788.0 8556.1 8773.5 8791.3 8792.1 8832.3 5726.4 6464.2 6565.5 6734.6 6738.1 7169.1 7355.6 7395.5 7410.7 7427.0 6424.3 6564.5 6616.8 6681.4 6689.3 6179.3 6317.6 6359.4 6422.1 6444.5 6146.9 6273.2 6274.8 6280.4 6287.3 4376.2 4462.0 4536.6 4540.8 4628.9 3690.6 3798.8 3859.8 3884.5 3960.4 00:41:46 INFO - PROCESS | 11322 | 00:41:46 INFO - PROCESS | 11322 | [#4] prototype.html Cycles:180 Average:4155.81 Median:4724.58 stddev:1221.03 (25.8%) stddev-sans-first:1189.48 00:41:46 INFO - PROCESS | 11322 | Values: 289.8 295.2 297.4 301.1 301.9 4739.0 4778.5 4792.4 4816.4 4859.4 4778.6 4796.1 4804.2 4840.3 4867.7 3579.2 3703.7 3735.5 3807.3 3823.2 3387.9 3731.8 3741.6 3747.4 3763.2 3733.4 3741.0 3741.7 3756.5 3765.9 3736.3 3750.4 3756.7 3760.8 3775.9 3162.1 3207.6 3312.0 3316.9 3324.9 4663.1 4672.7 4673.1 4683.0 4683.6 4293.4 4307.8 4332.7 4336.8 4356.8 4754.7 4973.0 5018.9 5047.3 5057.7 3548.8 3555.3 3566.7 3569.3 3573.4 4985.2 5143.9 5204.0 5257.6 5261.8 3541.9 3571.6 3579.0 3605.7 3674.4 3700.3 3711.6 3719.7 3720.8 3723.5 4231.2 4237.5 4249.3 4250.4 4266.0 4782.7 5002.5 5034.5 5050.7 5070.6 1297.8 1299.4 1301.6 1308.2 1312.3 798.9 829.8 840.3 843.7 851.9 4064.2 4065.6 4067.6 4068.9 4090.7 4607.6 4628.1 4629.8 4653.7 4668.6 4069.3 4088.8 4116.2 4125.7 4136.6 2466.8 2567.2 2774.8 2787.7 2800.7 4938.5 4950.7 4957.0 4973.7 4983.0 5209.8 5375.2 5380.8 5392.2 5416.9 4898.9 4928.4 4949.9 4956.0 4956.1 5217.3 5232.7 5237.3 5239.3 5283.2 4852.0 5080.8 5105.4 5116.1 5158.6 4710.2 4771.9 4928.6 4932.4 4968.8 3611.3 3640.8 3655.7 3656.9 3682.8 5274.4 5277.4 5296.8 5302.9 5305.4 5008.5 5076.0 5161.9 5161.9 5176.1 5047.5 5063.2 5076.4 5079.1 5082.7 4994.9 5004.9 5010.4 5076.7 5084.4 4839.5 5079.5 5130.2 5158.9 5160.3 4976.9 4980.1 4990.6 4992.9 4998.1 00:41:46 INFO - PROCESS | 11322 | 00:41:46 INFO - PROCESS | 11322 | [#5] yui.html Cycles:180 Average:16420.33 Median:24528.17 stddev:23696.96 (96.6%) stddev-sans-first:23733.85 00:41:46 INFO - PROCESS | 11322 | Values: 650.9 708.9 734.2 749.1 750.5 12696.6 13653.7 13714.2 13744.3 13768.5 12846.0 13066.9 13201.2 13315.9 13359.7 753.3 771.9 772.4 773.3 773.4 626.6 747.1 768.6 773.2 779.8 812.0 816.0 818.7 818.9 819.1 817.2 819.1 819.6 819.7 820.5 477.1 576.6 591.9 592.0 599.0 12500.2 12532.3 12537.2 12537.6 12542.4 11898.3 12624.6 12688.9 12704.6 13367.9 11387.4 11514.5 11566.4 11651.9 11775.9 3989.6 4000.4 4034.8 4175.4 4177.1 65775.7 66271.7 67340.3 67350.7 68594.0 9390.7 9586.2 9933.7 9966.5 9980.3 18001.3 18289.7 18297.9 18301.8 18304.1 6451.9 6507.2 6629.3 6654.7 6948.2 3761.2 3841.4 3850.1 3881.9 3885.2 2710.2 2759.3 2783.9 2826.6 2832.9 505.3 513.1 517.5 519.3 523.1 419.4 482.6 525.8 527.4 565.9 7315.3 7359.6 7498.8 7538.5 7998.6 548.7 555.4 603.8 608.0 628.0 3528.2 3657.8 3760.5 3867.3 3957.6 98360.5 100695.5 103240.0 103543.5 103594.5 52484.5 52735.2 52895.5 53080.7 79151.0 48573.8 77740.3 77937.0 78215.0 80402.6 7191.5 7282.2 7335.5 7413.5 7456.0 46469.8 46751.3 47931.3 48021.3 48163.5 39131.6 39492.0 39557.8 40646.2 41857.0 10071.7 10170.6 10229.8 10276.3 10488.5 11329.6 11356.6 11411.1 11426.4 11556.1 10246.4 10485.9 10594.4 10701.3 11015.8 10474.1 10606.7 10638.4 10782.2 10902.1 9712.9 10115.1 10356.1 10603.2 10937.4 8303.7 8527.5 8692.2 9126.5 9212.2 7737.5 7877.7 8605.4 8855.2 8924.7 00:41:46 INFO - PROCESS | 11322 | -------- Summary: end -------- 00:41:46 INFO - PROCESS | 11322 | 00:41:47 INFO - TEST-INFO | 11322: exit 0 00:41:47 INFO - TEST-OK | dromaeo_css | took 1119896ms 00:41:47 INFO - TEST-START | kraken 00:41:47 INFO - operating with platform_type : linux_ 00:41:47 INFO - Initialising browser for kraken test... 00:41:47 INFO - TEST-INFO | started process 11501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEfXDv/profile http://localhost:59304/getInfo.html) 00:41:51 INFO - PROCESS | 11501 | __metrics Screen width/height:1600/1200 00:41:51 INFO - PROCESS | 11501 | colorDepth:24 00:41:51 INFO - PROCESS | 11501 | Browser inner width/height: 1024/697 00:41:51 INFO - PROCESS | 11501 | __metrics 00:41:52 INFO - PROCESS | 11501 | 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" 00:41:52 INFO - PROCESS | 11501 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:41:53 INFO - TEST-INFO | 11501: exit 0 00:41:53 INFO - Browser initialized. 00:41:53 INFO - Running cycle 1/1 for kraken test... 00:41:53 INFO - TEST-INFO | started process 11583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEfXDv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:42:05 INFO - PROCESS | 11583 | RSS: Main: 157003776 00:42:05 INFO - PROCESS | 11583 | 00:42:08 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59304/tests/kraken/driver.html?testName=audio-beat-detection) 00:42:09 INFO - PROCESS | 11583 | RSS: Main: 214515712 00:42:09 INFO - PROCESS | 11583 | 00:42:11 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59304/tests/kraken/driver.html?testName=audio-dft) 00:42:12 INFO - PROCESS | 11583 | RSS: Main: 193101824 00:42:12 INFO - PROCESS | 11583 | 00:42:15 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59304/tests/kraken/driver.html?testName=audio-fft) 00:42:16 INFO - PROCESS | 11583 | RSS: Main: 271847424 00:42:16 INFO - PROCESS | 11583 | 00:42:18 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59304/tests/kraken/driver.html?testName=audio-oscillator) 00:42:19 INFO - PROCESS | 11583 | RSS: Main: 180703232 00:42:19 INFO - PROCESS | 11583 | 00:42:21 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:42:22 INFO - PROCESS | 11583 | RSS: Main: 185327616 00:42:22 INFO - PROCESS | 11583 | 00:42:25 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59304/tests/kraken/driver.html?testName=imaging-darkroom) 00:42:25 INFO - PROCESS | 11583 | RSS: Main: 221782016 00:42:25 INFO - PROCESS | 11583 | 00:42:29 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59304/tests/kraken/driver.html?testName=imaging-desaturate) 00:42:29 INFO - PROCESS | 11583 | RSS: Main: 221659136 00:42:29 INFO - PROCESS | 11583 | 00:42:32 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59304/tests/kraken/driver.html?testName=json-parse-financial) 00:42:33 INFO - PROCESS | 11583 | RSS: Main: 220635136 00:42:33 INFO - PROCESS | 11583 | 00:42:35 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:42:35 INFO - PROCESS | 11583 | RSS: Main: 185155584 00:42:35 INFO - PROCESS | 11583 | 00:42:37 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:42:38 INFO - PROCESS | 11583 | RSS: Main: 190902272 00:42:38 INFO - PROCESS | 11583 | 00:42:40 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:42:41 INFO - PROCESS | 11583 | RSS: Main: 195112960 00:42:41 INFO - PROCESS | 11583 | 00:42:43 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:42:44 INFO - PROCESS | 11583 | RSS: Main: 189726720 00:42:44 INFO - PROCESS | 11583 | 00:42:47 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:42:47 INFO - PROCESS | 11583 | RSS: Main: 192753664 00:42:47 INFO - PROCESS | 11583 | 00:42:49 INFO - PROCESS | 11583 | Cycle 1(1): loaded http://localhost:59304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59304/tests/kraken/driver.html?testName=ai-astar) 00:42:50 INFO - PROCESS | 11583 | RSS: Main: 243884032 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | __start_tp_report 00:42:50 INFO - PROCESS | 11583 | _x_x_mozilla_page_load 00:42:50 INFO - PROCESS | 11583 | _x_x_mozilla_page_load_details 00:42:50 INFO - PROCESS | 11583 | |i|pagename|runs| 00:42:50 INFO - PROCESS | 11583 | |0;ai-astar;104;114;114;114;113;112;113;113;112;113 00:42:50 INFO - PROCESS | 11583 | |1;audio-beat-detection;149;126;124;182;123;123;153;123;163;123 00:42:50 INFO - PROCESS | 11583 | |2;audio-dft;162;162;162;163;163;162;163;162;162;162 00:42:50 INFO - PROCESS | 11583 | |3;audio-fft;76;76;77;118;76;76;76;74;108;76 00:42:50 INFO - PROCESS | 11583 | |4;audio-oscillator;86;85;129;85;84;85;116;85;85;134 00:42:50 INFO - PROCESS | 11583 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 00:42:50 INFO - PROCESS | 11583 | |6;imaging-darkroom;146;148;147;146;146;147;147;145;146;147 00:42:50 INFO - PROCESS | 11583 | |7;imaging-desaturate;96;95;95;95;94;95;95;96;95;95 00:42:50 INFO - PROCESS | 11583 | |8;json-parse-financial;63;61;62;62;62;65;61;64;62;63 00:42:50 INFO - PROCESS | 11583 | |9;json-stringify-tinderbox;65;66;66;67;66;66;66;66;66;66 00:42:50 INFO - PROCESS | 11583 | |10;stanford-crypto-aes;86;79;88;79;79;80;80;80;79;90 00:42:50 INFO - PROCESS | 11583 | |11;stanford-crypto-ccm;130;142;143;131;144;127;137;131;169;129 00:42:50 INFO - PROCESS | 11583 | |12;stanford-crypto-pbkdf2;164;169;166;164;164;166;167;164;168;170 00:42:50 INFO - PROCESS | 11583 | |13;stanford-crypto-sha256-iterative;67;68;67;69;68;67;68;67;68;67 00:42:50 INFO - PROCESS | 11583 | __end_tp_report 00:42:50 INFO - PROCESS | 11583 | __start_cc_report 00:42:50 INFO - PROCESS | 11583 | _x_x_mozilla_cycle_collect,1917 00:42:50 INFO - PROCESS | 11583 | __end_cc_report 00:42:50 INFO - PROCESS | 11583 | __startTimestamp1470123770003__endTimestamp 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | ------- Summary: start ------- 00:42:50 INFO - PROCESS | 11583 | Number of tests: 14 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.97 (2.6%) stddev-sans-first:0.78 00:42:50 INFO - PROCESS | 11583 | Values: 104.0 114.0 114.0 114.0 113.0 112.0 113.0 113.0 112.0 113.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:137.50 stddev:21.44 (15.6%) stddev-sans-first:22.43 00:42:50 INFO - PROCESS | 11583 | Values: 149.0 126.0 124.0 182.0 123.0 123.0 153.0 123.0 163.0 123.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 00:42:50 INFO - PROCESS | 11583 | Values: 162.0 162.0 162.0 163.0 163.0 162.0 163.0 162.0 162.0 162.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.85 (20.9%) stddev-sans-first:16.59 00:42:50 INFO - PROCESS | 11583 | Values: 76.0 76.0 77.0 118.0 76.0 76.0 76.0 74.0 108.0 76.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:85.00 stddev:20.45 (24.1%) stddev-sans-first:21.27 00:42:50 INFO - PROCESS | 11583 | Values: 86.0 85.0 129.0 85.0 84.0 85.0 116.0 85.0 85.0 134.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:42:50 INFO - PROCESS | 11583 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 00:42:50 INFO - PROCESS | 11583 | Values: 146.0 148.0 147.0 146.0 146.0 147.0 147.0 145.0 146.0 147.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 00:42:50 INFO - PROCESS | 11583 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 95.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.50 stddev:1.27 (2.0%) stddev-sans-first:1.33 00:42:50 INFO - PROCESS | 11583 | Values: 63.0 61.0 62.0 62.0 62.0 65.0 61.0 64.0 62.0 63.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 00:42:50 INFO - PROCESS | 11583 | Values: 65.0 66.0 66.0 67.0 66.0 66.0 66.0 66.0 66.0 66.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:80.00 stddev:4.27 (5.3%) stddev-sans-first:4.28 00:42:50 INFO - PROCESS | 11583 | Values: 86.0 79.0 88.0 79.0 79.0 80.0 80.0 80.0 79.0 90.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:139.50 stddev:12.48 (8.9%) stddev-sans-first:12.87 00:42:50 INFO - PROCESS | 11583 | Values: 130.0 142.0 143.0 131.0 144.0 127.0 137.0 131.0 169.0 129.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:2.25 (1.4%) stddev-sans-first:2.24 00:42:50 INFO - PROCESS | 11583 | Values: 164.0 169.0 166.0 164.0 164.0 166.0 167.0 164.0 168.0 170.0 00:42:50 INFO - PROCESS | 11583 | 00:42:50 INFO - PROCESS | 11583 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 00:42:50 INFO - PROCESS | 11583 | Values: 67.0 68.0 67.0 69.0 68.0 67.0 68.0 67.0 68.0 67.0 00:42:50 INFO - PROCESS | 11583 | -------- Summary: end -------- 00:42:50 INFO - PROCESS | 11583 | 00:42:51 INFO - TEST-INFO | 11583: exit 0 00:42:51 INFO - TEST-OK | kraken | took 63504ms 00:42:51 INFO - SUITE-END | took 1183s 00:42:51 INFO - Completed test suite (00:19:43) 00:42:51 INFO - javascript benchmark 00:42:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.647427597274, 2635.4202075543376, 2645.6163856240846, 2650.3639126609605, 2660.5876089206167, 4577.992841574856, 4668.486466488684, 4730.1012807566585, 4753.405824271966, 4764.380630518032, 4663.790129444174, 4690.273007683806, 4717.410323709528, 4732.716037037781, 4797.0885531748945, 4336.241157797389, 4348.6521078313735, 4435.911281774363, 4441.444819397575, 4456.175607512604, 4362.825486980517, 4424.181526417607, 4443.37792709021, 4461.286194208928, 4505.481869585007, 4412.0, 4452.866414007585, 4466.196084704752, 4470.351798989144, 4470.396496472983, 4244.893877653083, 4300.74195548265, 4362.541933097043, 4411.228035093845, 4412.294032954712, 4287.592678695519, 4289.270823959934, 4289.892752681177, 4300.8709738707885, 4329.696921215516, 4737.573618374363, 4752.619790416758, 4776.593989510896, 4804.399450068741, 4823.204171311764, 4919.163742163841, 5082.872928176826, 5107.106256405114, 5110.744462776884, 5157.742112894341, 5030.823921162779, 5065.392152941634, 5124.641275110744, 5141.485851414866, 5184.7407629618365, 4797.904041919142, 4808.735519546389, 4824.8793780155775, 4827.927581086286, 4832.178529649968, 5012.573931215815, 5169.71566563835, 5275.815346462856, 5294.655847369909, 5297.417284098746, 5003.024410239968, 5052.747362631853, 5078.3905931287745, 5090.338256026767, 5096.490350964874, 5119.180931051014, 5124.9510457616725, 5138.306328645585, 5139.743012849417, 5171.818986335536, 4892.119418504703, 4960.851174464772, 5051.520105590037, 5061.822836200715, 5065.442801291855, 4961.627877909171, 5017.8243761468175, 5022.84931452057, 5072.898542029138, 5093.0577843099145, 4220.725652832618, 4233.322668373107, 4239.04621460169, 4239.59723826236, 4278.893027674333, 3767.660910518012, 3780.546334439885, 3782.0355809268463, 3782.8486860525272, 3787.3750831113107, 4286.507051689034, 4378.0806030733265, 4436.778161091933, 4437.667174961891, 4494.865154045384, 5125.256837758504, 5147.253648220987, 5149.819756308586, 5149.845504634867, 5191.6884986900905, 4440.844570440084, 4447.066116115652, 4450.955490445119, 4456.888577785581, 4503.076869241798, 4355.956440435619, 4425.778711064434, 4466.531014243457, 4471.083427897273, 4537.047220083753, 4784.545468180518, 4796.232602783468, 4800.543948324904, 4810.086083644096, 4856.587190088882, 5066.493350664904, 5070.771815268248, 5078.111330517071, 5078.289039534394, 5127.051495473349, 4656.557627025427, 4790.137775200497, 4835.854924352275, 4849.515048495122, 4929.112759703288, 5036.874078148076, 5082.517160869711, 5089.592832573311, 5091.0581542414775, 5141.53726164647, 5137.229415587692, 5147.202183661539, 5149.639525233198, 5150.562202212854, 5150.639455238097, 4827.806887724451, 4892.608591312757, 4931.852044438672, 4948.604111671129, 5001.474845141353, 4964.205727083649, 4972.129877271535, 4973.179425394769, 4973.850784476472, 4999.525045120708, 4888.388951381077, 4890.584300334512, 4900.338454308623, 4903.313536104877, 4930.728809915489, 4792.904141917073, 4845.466998630078, 4847.345608342828, 4895.926561101657, 4915.164422048332, 4820.132376172322, 4829.154897892925, 4875.3174555562955, 4899.657024008286, 4961.181405068123], "value": 4671.105816889963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.7513556467372, 565.2623326558839, 577.7140315543807, 589.5548860610238, 592.0615823919088, 29245.707542924563, 39317.606823931754, 40793.796031019876, 40871.795641021825, 44787.552124478745, 40859.38710919338, 41146.38280425796, 41182.17635647285, 41194.7940260299, 41203.0, 7390.224026477224, 7637.73267935621, 7773.650185741655, 7777.066751989769, 7784.455088143804, 9847.16299114576, 10127.392356458637, 10155.0, 10467.685969420929, 10469.84295235572, 10087.848682269736, 10173.745656358577, 10195.031472010147, 10198.082172604463, 10201.234907381939, 7474.738384156529, 9805.607775688964, 9994.90005099947, 9999.200063994864, 10042.9497852511, 9721.368111072758, 10089.596416143419, 10093.444860532667, 10099.192064634812, 10107.444090575016, 38056.80971595124, 38376.61623383759, 38382.80808595939, 38385.16148385167, 38393.232135357415, 3003.7747168962196, 3050.391959500007, 3106.9533956990663, 3168.8732450701946, 3303.223742420529, 29684.70315296841, 29709.257268568243, 30331.393372132654, 30955.845220773754, 31380.529292060637, 3211.775175737699, 3232.7252183564424, 3279.5736554247796, 3389.6440873708398, 3404.063882432326, 253178.0, 255527.0, 255791.0, 256010.0, 256133.0, 31488.212794679857, 54992.72503637536, 55268.44731552713, 55369.0, 55370.44629553734, 33562.83218583892, 33724.49413258803, 33732.0, 33735.83132084373, 33817.0, 13534.18794872291, 13688.315584220749, 13692.383842727102, 13695.794563081561, 13708.725825483434, 9415.905840941503, 11526.0, 11609.535618575163, 11744.530218791153, 11852.644420667393, 7873.055233372032, 7885.44801863864, 7887.881681774778, 7956.403269754792, 7968.60156992148, 3127.890523831655, 3156.352947645727, 3163.4463968805367, 3166.4617015107488, 3185.394774992744, 856.8072183758604, 903.4985583001497, 976.1556253840519, 986.4328011393334, 995.7411073121041, 27911.325320480835, 29056.7094329054, 29461.55807662887, 29490.262743431158, 29636.0, 939.2043512505338, 970.6069042037985, 1023.2888142740724, 1035.8601588785568, 1046.8639076920103, 15214.163221022729, 15251.389944402099, 15301.0, 15384.230788460532, 15609.453669121527, 394531.0, 395385.0, 397409.0, 398796.0, 399114.0, 50588.241176382384, 51005.489945100075, 51258.0, 51259.0, 51415.48584514182, 1072.2922870905165, 1123.1239633086207, 1126.6169502369235, 1187.4597058338436, 1196.485511230162, 23597.646035309142, 28687.569686454302, 29886.85056574703, 30389.848050759603, 31196.0, 46231.30653040274, 52189.7390513045, 52198.21702674539, 52228.47771522236, 52235.216471752196, 367076.0, 369260.0, 370763.0, 370772.0, 371911.0, 30948.381032378777, 34509.827450862584, 34665.48001779925, 40685.79657101695, 41769.16461670689, 38996.415053774785, 42421.575784242996, 43130.0, 43217.35173972456, 43477.13045739131, 36077.27845443024, 37374.252514950094, 37641.05897352588, 37799.433008505446, 39079.0, 37148.81425592963, 37636.24727505489, 38449.23101538009, 38858.80570597129, 38951.61048389593, 36936.815315923246, 37145.25709485849, 37239.25521489609, 37824.24351512899, 38075.0, 32544.186395340304, 34794.0, 35038.12404689903, 35311.0, 35479.64520354763, 26131.216063518124, 26369.736302636727, 26538.86730566335, 26540.469190615695, 26615.733842661324], "value": 17507.154864954176, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.53776435045313, 363.53830635093425, 368.86167687117313, 379.886034189743, 386.5496696348754, 16001.0, 16950.0, 17649.117544122808, 17765.7335139973, 17765.7335139973, 16780.0, 17443.127843607832, 17605.207765650546, 17698.646027079452, 17718.82281177191, 5051.823186188475, 5309.389420216667, 5310.362756469229, 5313.415524292324, 5314.335708036496, 3575.3921833288273, 3677.5219221501166, 3710.5361829771277, 5241.554467870235, 5445.428230035829, 6323.9051414228825, 6332.683365831713, 6336.778212762554, 6337.461315788163, 6338.144350512691, 6060.3939606039485, 6172.876542469148, 6197.287311959138, 6200.069989501566, 6323.77866774663, 5467.863303417406, 5469.124940009619, 5470.124780035176, 5472.480114389126, 5473.644213126134, 12108.21296615726, 15858.36566537337, 20077.397678069683, 20920.895395523075, 21081.789182108136, 1922.404054743034, 1972.7336809530673, 2037.0481266343247, 2341.555104530134, 2362.5511152881068, 8692.391532592721, 9404.764880878032, 9594.088561586637, 12456.377181140997, 12665.556705515262, 1639.3934244329555, 1660.7093758592318, 1714.9314027438888, 1761.0930370859019, 1808.2495764257817, 62965.0, 67605.66197168983, 67860.32139678638, 68702.65648671724, 68903.0, 8135.3491720662205, 8565.914340856512, 8682.6092825823, 8696.565171741388, 9763.658271960447, 11335.376554289593, 11405.0, 11412.600558980395, 11413.543458261576, 11414.258073225214, 6748.4938629602975, 6896.689648965808, 6988.755393561302, 7046.401055910203, 7051.29487051301, 6904.067950826574, 6979.651017449107, 7118.359347658736, 7125.75059872902, 7156.069710937545, 3516.4373700207843, 3613.2231570212007, 3621.3119507294055, 3672.9899277698314, 3715.256948610289, 1694.4831826292852, 1721.8966861988322, 1749.3964582219114, 1776.7512548243255, 1809.2943751936755, 794.7417089445953, 806.3629732511367, 829.9751007469665, 844.2317491083207, 884.5488800711684, 16502.954779673382, 16605.83394166043, 17345.13274336278, 17723.11384430799, 17991.190396432194, 805.5569436809732, 846.6697987784769, 851.8764779107119, 857.3398483167925, 867.9522626255616, 9112.95443522778, 9574.760630984281, 9821.116099551075, 9867.512150517283, 9906.157976571927, 377260.0, 403151.0, 403899.0, 404476.0, 406035.0, 79516.6024169887, 79546.6022669883, 79790.0, 80669.0, 80688.0, 894.494610545027, 905.4160066756905, 914.1772404835568, 923.7782932096248, 926.7312479380904, 15140.621484462976, 15314.770278445609, 15601.921990390429, 15725.292361843973, 15960.920195398949, 33070.50394244136, 38223.0, 38647.80676096714, 38948.2210355797, 39620.00949976274, 52209.21686174787, 52501.21248181204, 53567.73216133894, 53659.73170134125, 53899.73050134881, 6447.3552644735155, 6699.129113215251, 7138.0, 7388.6675099621725, 7623.9618801905635, 10292.845607316047, 11812.586559470377, 11840.407979600814, 11887.108466865193, 12166.148369614042, 9848.950755246178, 10384.32501887375, 10429.895701042893, 10462.947685261524, 10479.42363170033, 9885.50572471388, 10163.390196588229, 10193.643222487177, 10230.539625716712, 10505.632302869362, 9961.900380996098, 10121.240906931862, 10123.0, 10159.238057145596, 10742.51658675377, 6669.333066693292, 6822.488313376417, 6949.3745562899585, 6965.860682786215, 7008.474364422586, 7535.6985720570565, 10411.47942602882, 10465.64116809615, 10496.580136794748, 10807.783844323227], "value": 8102.2535806164105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1233.827264183014, 1307.856135825059, 1375.807386965825, 1408.3169662713583, 1608.3807734022398, 6348.968255158724, 7006.404455621272, 7280.708771649128, 7281.199068102511, 7512.248775122485, 7351.963240183792, 7387.630618469068, 7395.667194976226, 7399.963000185005, 7403.185649578542, 2129.2760461443145, 2162.50262439639, 2164.4588852786806, 2164.5238047629573, 2165.7076294700173, 2100.170432679091, 2137.3908436095717, 2169.511859831541, 2170.8371872109574, 2172.2722887832597, 2118.0998075817793, 2140.2616097446357, 2143.528423746781, 2156.169874598283, 2157.5361297321074, 2051.6101940631306, 2053.3429302623167, 2057.1565658080267, 2059.3718915730697, 2065.989670051655, 2053.3121404329568, 2110.778368271325, 2120.777318381563, 2121.4060063182333, 2136.978630213709, 7218.530795498275, 7395.4083673306, 7402.444816638774, 7409.407247420193, 7460.03019607453, 4237.512686041114, 4447.088346888912, 4457.086297309044, 4470.0, 4472.552744725534, 2901.956470652942, 3001.1296723950027, 3034.78756487046, 3063.9693603063906, 3064.387122575494, 906.9229115525188, 914.3964983111115, 928.3826255540058, 935.2471260635186, 937.8358787212279, 9479.0, 9520.666776662783, 9528.094830991045, 9550.95224523873, 9567.712968610884, 3779.149691319431, 3844.0, 3916.9020774480864, 3919.666828319625, 3996.320625493673, 7735.806604834924, 7785.571793551296, 7786.4938778979185, 7788.065432148179, 7790.026246719161, 4360.236958532308, 4382.671299652538, 4384.934225986613, 4392.3191905254735, 4395.912081758411, 3421.0934102462866, 3963.58382369847, 4036.6770658347264, 4056.5740597236863, 4124.876253712393, 3322.6511216321937, 3324.9335013299597, 3431.897043088711, 3440.4323286657423, 3440.82795860206, 1023.2632504596678, 1035.8239099352977, 1039.5789705169418, 1056.984145237822, 1061.363182090755, 844.5270648436895, 868.769776009358, 872.6858331000834, 907.0249481807084, 908.0329449136781, 5221.686698798084, 5230.189320655304, 5251.059406732242, 5385.165299378603, 5386.434424385383, 848.2154007542998, 860.3246451535515, 879.683314006957, 880.2693764175718, 884.920357167845, 3467.8439470223902, 3648.835802388899, 3669.486271921933, 3745.606711295329, 3864.2851072551107, 8531.189536993976, 8745.212930836255, 8918.73243802674, 8954.955225223832, 8960.820783584291, 8928.910710892938, 8929.419587726778, 8929.955350223338, 8946.150115738994, 8953.641854325884, 7016.473764467583, 7021.613811240329, 7093.680784364613, 7105.147382314155, 7111.96444017787, 5114.616403769806, 5219.582433405242, 5230.0, 5282.603804714585, 5304.867378315419, 8520.423721611522, 8668.566571671518, 8684.04475507681, 8721.825563488568, 8788.0, 8556.144385561644, 8773.517456539952, 8791.296696264411, 8792.120787921156, 8832.337574681796, 5726.427357264407, 6464.22429308486, 6565.540412171103, 6734.56225345351, 6738.056672066013, 7169.068021157216, 7355.632218388952, 7395.482316237812, 7410.6665200065045, 7427.034485517064, 6424.261209960728, 6564.4748420127235, 6616.801495955129, 6681.432078273207, 6689.297623749436, 6179.28938172116, 6317.6209427434505, 6359.4276515112015, 6422.133012043501, 6444.548881578245, 6146.907796383147, 6273.215848018997, 6274.843128921813, 6280.434760871543, 6287.2769631492965, 4376.234159022222, 4461.977690111528, 4536.56902594253, 4540.841070562515, 4628.907421851477, 3690.5940346562393, 3798.772073675588, 3859.826307816099, 3884.4561761354, 3960.386140148282], "value": 3968.2901461855586, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.7899023208174, 295.2132566709718, 297.4155783884666, 301.0862033727637, 301.942630900129, 4739.0, 4778.4504781950045, 4792.376990991171, 4816.397950256218, 4859.392575928009, 4778.569928706415, 4796.129509491301, 4804.159272127373, 4840.322354870321, 4867.68360056597, 3579.158897659048, 3703.7222208334347, 3735.4583585380237, 3807.2575847709777, 3823.2162406706557, 3387.8644854205804, 3731.794751288678, 3741.625837416264, 3747.4191500317493, 3763.1721021375392, 3733.439984002408, 3740.9812950935343, 3741.681957033655, 3756.492873462075, 3765.868194613189, 3736.327461057009, 3750.362438385467, 3756.7370284080125, 3760.793156376398, 3775.9433608495897, 3162.130414136108, 3207.5990501187352, 3311.9503207451908, 3316.93366132676, 3324.9168770780684, 4663.137319595886, 4672.696274742131, 4673.135469938038, 4682.953170468286, 4683.62778799264, 4293.355996600504, 4307.763073030982, 4332.696711230215, 4336.7831608419765, 4356.8257269709175, 4754.738489383082, 4973.0, 5018.949810501885, 5047.268146118829, 5057.747112644353, 3548.787072775616, 3555.306715190539, 3566.715982246389, 3569.303985722785, 3573.3746594345885, 4985.227289770055, 5143.922841157349, 5203.973980130075, 5257.553107985787, 5261.84264451573, 3541.8760343387858, 3571.607123216444, 3578.982105089458, 3605.6935160511125, 3674.375356189454, 3700.315441643251, 3711.554613446404, 3719.6652301293016, 3720.776753394805, 3723.515942927402, 4231.217224813419, 4237.453329534697, 4249.277622804131, 4250.362445633118, 4265.957340426556, 4782.689125206851, 5002.549770520671, 5034.521720436553, 5050.696958182521, 5070.569001634829, 1297.8312819333426, 1299.4152631315756, 1301.6160232731368, 1308.1693124865778, 1312.3241530611742, 798.856205882935, 829.7676650537859, 840.2689659995842, 843.700486327345, 851.9105493923173, 4064.1871625674985, 4065.57311482296, 4067.5525692173837, 4068.898277543026, 4090.7136500444685, 4607.608353289941, 4628.074385122989, 4629.800844598856, 4653.7207767534055, 4668.5798278155125, 4069.328560787437, 4088.814243869245, 4116.197341518435, 4125.66994640428, 4136.6483848872585, 2466.79032282258, 2567.242663414297, 2774.8196367236064, 2787.7212278771963, 2800.705925877794, 4938.530839570235, 4950.653454258168, 4956.951474842946, 4973.73169841688, 4982.975085124551, 5209.762816066372, 5375.220593014069, 5380.757865896044, 5392.191171324254, 5416.945830541644, 4898.853034408973, 4928.359313289249, 4949.851504454872, 4955.975220123948, 4956.141446957391, 5217.269582258563, 5232.712200828991, 5237.2667826505085, 5239.345081864767, 5283.1546952487415, 4851.975740121418, 5080.847574572768, 5105.361829771278, 5116.130257856248, 5158.6131040171385, 4710.152172608826, 4771.856844294677, 4928.581070608895, 4932.383452068491, 4968.826091086795, 3611.2777444510675, 3640.7997560133385, 3655.6527129922615, 3656.8902932912056, 3682.797446140488, 5274.393444753749, 5277.4194838566955, 5296.814611488733, 5302.893942121059, 5305.389880163831, 5008.524190201925, 5076.0, 5161.948380516147, 5161.948380516147, 5176.094183517794, 5047.520485553867, 5063.215201643751, 5076.441591424867, 5079.136546787129, 5082.745862706776, 4994.850154495371, 5004.899902002013, 5010.39667306473, 5076.695398276115, 5084.3644544431945, 4839.491853355347, 5079.492050795039, 5130.204818253177, 5158.948410515847, 5160.329157209539, 4976.850694479172, 4980.132450331126, 4990.581451705593, 4992.8751781205765, 4998.075740839876], "value": 3768.8378913768966, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.8665723526676, 708.861771954469, 734.1813877526556, 749.0599297881162, 750.5346685055266, 12696.61910142695, 13653.726925461484, 13714.24571648559, 13744.312784360767, 13768.518101866437, 12846.03654725897, 13066.869331306683, 13201.207927524356, 13315.933420332909, 13359.732805343912, 753.3257734327759, 771.8880762289465, 772.4013889235831, 773.3233420756837, 773.3812949640294, 626.6208943589131, 747.0773594610652, 768.6387397922967, 773.1997382708897, 779.7894568466511, 812.0, 816.0207750699155, 818.7175424478545, 818.8935438393, 819.1030821250721, 817.2277198047847, 819.1153554161491, 819.5983967855767, 819.663937785511, 820.5363969357294, 477.0911413756799, 576.6223123853882, 591.8905002574537, 592.0497601349857, 598.9610675306092, 12500.187487813353, 12532.310722910237, 12537.185082969578, 12537.56118535856, 12542.435590398454, 11898.345590992492, 12624.558140465131, 12688.936555317165, 12704.555340563129, 13367.933160334233, 11387.430628468626, 11514.481848316846, 11566.42167891602, 11651.883481165249, 11775.882241177564, 3989.6209860063245, 4000.399940008993, 4034.7895631310785, 4175.373693945902, 4177.10192308652, 65775.67112164457, 66271.66864165648, 67340.3265967339, 67350.66324668394, 68594.0, 9390.718278451657, 9586.233101351874, 9933.65232216869, 9966.501674916226, 9980.301378903407, 18001.279948802163, 18289.7256541152, 18297.908510457364, 18301.816981830012, 18304.084795760424, 6451.9354806452275, 6507.1540699709685, 6629.337066293332, 6654.6672666366485, 6948.200956889921, 3761.191343861083, 3841.4045822897497, 3850.1144736710153, 3881.941770873439, 3885.2229554089295, 2710.1733971138597, 2759.300075127004, 2783.916482505528, 2826.6042754014456, 2832.929176770597, 505.2724077328635, 513.0969493691131, 517.4644243208337, 519.2833889232835, 523.0611053159588, 419.4253872195112, 482.5753337063432, 525.8037963632767, 527.3592585009233, 565.913446183329, 7315.341619254186, 7359.558426494427, 7498.812529686801, 7538.472306938462, 7998.5600791957, 548.6680558262274, 555.4112640600976, 603.7554790309931, 607.9726412311456, 628.0359647940389, 3528.1532432216595, 3657.817109144532, 3760.4547340636, 3867.2652196082654, 3957.604239576019, 98360.50819745855, 100695.49652251838, 103240.0, 103543.4822825881, 103594.48202758937, 52484.47515524872, 52735.20897186468, 52895.47104528982, 53080.734596327544, 79151.0, 48573.757131214115, 77740.28246469192, 77937.0, 78215.0, 80402.59798700969, 7191.460640451883, 7282.162551306667, 7335.486515943832, 7413.518121322097, 7456.02494278146, 46469.76765116153, 46751.29873051839, 47931.281030783866, 48021.27968080551, 48163.5183648159, 39131.60868391394, 39492.0, 39557.80221098876, 40646.1870762589, 41857.0, 10071.697849064247, 10170.644027459004, 10229.795404092025, 10276.332038417479, 10488.475576221006, 11329.610827420569, 11356.602518911799, 11411.144164187885, 11426.428678566204, 11556.075513959031, 10246.436445995541, 10485.895141048797, 10594.417307048187, 10701.250912436055, 11015.83476247841, 10474.109700675528, 10606.734831629272, 10638.361698298128, 10782.245242832927, 10902.073323767569, 9712.854307185538, 10115.14021308197, 10356.067953884187, 10603.151747860307, 10937.398443085707, 8303.667853286042, 8527.48835069873, 8692.174243446863, 9126.45241285525, 9212.216961558343, 7737.497062690907, 7877.684892604461, 8605.440646357967, 8855.203031727175, 8924.732258032269], "value": 6256.473618448771, "unit": "score"}], "name": "dromaeo_css", "value": 6291.277073299413, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 114.0, 113.0, 112.0, 113.0, 113.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 124.0, 182.0, 123.0, 123.0, 153.0, 123.0, 163.0, 123.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 163.0, 162.0, 163.0, 162.0, 162.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 118.0, 76.0, 76.0, 76.0, 74.0, 108.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 129.0, 85.0, 84.0, 85.0, 116.0, 85.0, 85.0, 134.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 62.0, 62.0, 65.0, 61.0, 64.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 88.0, 79.0, 79.0, 80.0, 80.0, 80.0, 79.0, 90.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 142.0, 143.0, 131.0, 144.0, 127.0, 137.0, 131.0, 169.0, 129.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 166.0, 164.0, 164.0, 166.0, 167.0, 164.0, 168.0, 170.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 69.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1535.1999999999998, "alertThreshold": 2.0}]} 00:42:51 INFO - Return code: 0 00:42:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:42:51 INFO - # TBPL SUCCESS # 00:42:51 INFO - Running post-action listener: _resource_record_post_action 00:42:51 INFO - [mozharness: 2016-08-02 07:42:51.279079Z] Finished run-tests step (success) 00:42:51 INFO - Running post-run listener: _resource_record_post_run 00:42:51 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 521842688; Read time: 0; Write time: 412792 00:42:51 INFO - TinderboxPrint: CPU usage
13.0% 00:42:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:42:51 INFO - TinderboxPrint: I/O write bytes / time
521,842,688 / 412,792 00:42:51 INFO - TinderboxPrint: CPU idle
8,333.9 (87.0%) 00:42:51 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 00:42:51 INFO - TinderboxPrint: Swap in / out
0 / 0 00:42:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237506560; Read time: 0; Write time: 218948 00:42:51 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284336128; Read time: 0; Write time: 193844 00:42:51 INFO - Running post-run listener: _upload_blobber_files 00:42:51 INFO - Blob upload gear active. 00:42:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:42:51 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 00:42:51 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'] 00:42:51 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 00:42:52 INFO - (blobuploader) - INFO - Open directory for files ... 00:42:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:42:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:42:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:42:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:42:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:42:57 INFO - (blobuploader) - INFO - Done attempting. 00:42:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:42:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:42:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:42:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:42:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:42:58 INFO - (blobuploader) - INFO - Done attempting. 00:42:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:42:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:42:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:42:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:42:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:42:58 INFO - (blobuploader) - INFO - Done attempting. 00:42:58 INFO - (blobuploader) - INFO - Iteration through files over. 00:42:58 INFO - Return code: 0 00:42:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:42:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:42:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d2d61eab96e5075c810b882b6512917e56ccd658a45b5da39031055d4bdebd1b9fc90c1520782304949672d3c82129df9eda7ba1107e0b21cc23870c498290f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dcf91ab2ec16bbadb50fd48bd477d827190d94d8e1ad95a812443efedfabb2cdadd950ba879e84c15519654652bfd555759a2fd796e2b15a66ddd4964e6ca5c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d40a83f11ecb174e054a4477bbf59ef62aa1680dfb36986456662ff734792bba8c9cbb0881f594cd43898e9fe36065c3b23f509be9a73842a38bf4c5b84b8493"} 00:42:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:42:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:42:58 INFO - Contents: 00:42:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d2d61eab96e5075c810b882b6512917e56ccd658a45b5da39031055d4bdebd1b9fc90c1520782304949672d3c82129df9eda7ba1107e0b21cc23870c498290f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dcf91ab2ec16bbadb50fd48bd477d827190d94d8e1ad95a812443efedfabb2cdadd950ba879e84c15519654652bfd555759a2fd796e2b15a66ddd4964e6ca5c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d40a83f11ecb174e054a4477bbf59ef62aa1680dfb36986456662ff734792bba8c9cbb0881f594cd43898e9fe36065c3b23f509be9a73842a38bf4c5b84b8493"} 00:42:58 INFO - Running post-run listener: copy_logs_to_upload_dir 00:42:58 INFO - Copying logs to upload dir... 00:42:58 INFO - mkdir: /builds/slave/test/build/upload/logs 00:42:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.391022 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-08-02 00:42:58.757007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 00:42:58.761066) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091 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/d2d61eab96e5075c810b882b6512917e56ccd658a45b5da39031055d4bdebd1b9fc90c1520782304949672d3c82129df9eda7ba1107e0b21cc23870c498290f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dcf91ab2ec16bbadb50fd48bd477d827190d94d8e1ad95a812443efedfabb2cdadd950ba879e84c15519654652bfd555759a2fd796e2b15a66ddd4964e6ca5c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d40a83f11ecb174e054a4477bbf59ef62aa1680dfb36986456662ff734792bba8c9cbb0881f594cd43898e9fe36065c3b23f509be9a73842a38bf4c5b84b8493"} build_url:https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/d8YSVNVBSy-dqzJCS8oGdQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d2d61eab96e5075c810b882b6512917e56ccd658a45b5da39031055d4bdebd1b9fc90c1520782304949672d3c82129df9eda7ba1107e0b21cc23870c498290f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dcf91ab2ec16bbadb50fd48bd477d827190d94d8e1ad95a812443efedfabb2cdadd950ba879e84c15519654652bfd555759a2fd796e2b15a66ddd4964e6ca5c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d40a83f11ecb174e054a4477bbf59ef62aa1680dfb36986456662ff734792bba8c9cbb0881f594cd43898e9fe36065c3b23f509be9a73842a38bf4c5b84b8493"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 00:42:58.791688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 00:42:58.792000) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470118862.308526-799877091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 00:42:58.877789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 00:42:58.878542) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 00:42:58.879393) ========= ========= Total master_lag: 0.21 =========