builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1469790537.06 results: success (0) buildid: 20160729025526 builduid: cba0db5657da4bfdab950eb156c3b1de revision: 4dc4d45c2115f8805f15e10c0bf0e776408af0d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:57.063854) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:57.064265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:57.064867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:57.095996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:57.096265) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 04:08:57-- 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.4M=0s 2016-07-29 04:08:57 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:57.197938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:57.198240) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017583 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:57.281960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:57.282287) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4dc4d45c2115f8805f15e10c0bf0e776408af0d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4dc4d45c2115f8805f15e10c0bf0e776408af0d2 --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=e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 04:08:58,085 truncating revision to first 12 chars 2016-07-29 04:08:58,085 Setting DEBUG logging. 2016-07-29 04:08:58,085 attempt 1/10 2016-07-29 04:08:58,085 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4dc4d45c2115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 04:08:58,480 unpacking tar archive at: mozilla-central-4dc4d45c2115/testing/mozharness/ program finished with exit code 0 elapsedTime=0.755603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:58.051269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:58.051575) ========= script_repo_revision: 4dc4d45c2115f8805f15e10c0bf0e776408af0d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:58.052019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:58.052288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 04:08:58.062924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-29 04:08:58.063205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:58 INFO - MultiFileLogger online at 20160729 04:08:58 in /builds/slave/test 04:08:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:08:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:58 INFO - {'append_to_log': False, 04:08:58 INFO - 'base_work_dir': '/builds/slave/test', 04:08:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:08:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:58 INFO - 'branch': 'Firefox-Non-PGO', 04:08:58 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:58 INFO - 'config_files': ('talos/linux_config.py',), 04:08:58 INFO - 'default_actions': ('clobber', 04:08:58 INFO - 'read-buildbot-config', 04:08:58 INFO - 'download-and-extract', 04:08:58 INFO - 'populate-webroot', 04:08:58 INFO - 'create-virtualenv', 04:08:58 INFO - 'install', 04:08:58 INFO - 'run-tests'), 04:08:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:58 INFO - 'download_minidump_stackwalk': True, 04:08:58 INFO - 'download_symbols': 'ondemand', 04:08:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:58 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:58 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:58 INFO - 'installer_path': 'installer.exe', 04:08:58 INFO - 'log_level': 'info', 04:08:58 INFO - 'log_name': 'talos', 04:08:58 INFO - 'log_to_console': True, 04:08:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:58 INFO - 'opt_config_files': (), 04:08:58 INFO - 'pip_index': False, 04:08:58 INFO - 'sps_profile': False, 04:08:58 INFO - 'sps_profile_interval': 0, 04:08:58 INFO - 'suite': 'dromaeojs', 04:08:58 INFO - 'system_bits': '32', 04:08:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:58 INFO - 'title': 'talos-linux64-ix-067', 04:08:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:58 INFO - 'use_talos_json': True, 04:08:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:58 INFO - 'work_dir': 'build'} 04:08:58 INFO - [mozharness: 2016-07-29 11:08:58.953814Z] Running clobber step. 04:08:58 INFO - Running pre-action listener: _resource_record_pre_action 04:08:58 INFO - Running main action method: clobber 04:08:58 INFO - rmtree: /builds/slave/test/build 04:08:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:59 INFO - Running post-action listener: _resource_record_post_action 04:08:59 INFO - [mozharness: 2016-07-29 11:08:59.427880Z] Finished clobber step (success) 04:08:59 INFO - [mozharness: 2016-07-29 11:08:59.427981Z] Running read-buildbot-config step. 04:08:59 INFO - Running pre-action listener: _resource_record_pre_action 04:08:59 INFO - Running main action method: read_buildbot_config 04:08:59 INFO - Using buildbot properties: 04:08:59 INFO - { 04:08:59 INFO - "project": "", 04:08:59 INFO - "product": "firefox", 04:08:59 INFO - "script_repo_revision": "production", 04:08:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:08:59 INFO - "repository": "", 04:08:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:08:59 INFO - "buildid": "20160729025526", 04:08:59 INFO - "pgo_build": "False", 04:08:59 INFO - "basedir": "/builds/slave/test", 04:08:59 INFO - "buildnumber": 665, 04:08:59 INFO - "slavename": "talos-linux64-ix-067", 04:08:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:08:59 INFO - "platform": "ubuntu64_hw", 04:08:59 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:08:59 INFO - "branch": "mozilla-central", 04:08:59 INFO - "repo_path": "mozilla-central", 04:08:59 INFO - "revision": "4dc4d45c2115f8805f15e10c0bf0e776408af0d2", 04:08:59 INFO - "stage_platform": "linux64", 04:08:59 INFO - "builduid": "cba0db5657da4bfdab950eb156c3b1de", 04:08:59 INFO - "slavebuilddir": "test" 04:08:59 INFO - } 04:08:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:08:59 INFO - Running post-action listener: _resource_record_post_action 04:08:59 INFO - [mozharness: 2016-07-29 11:08:59.430435Z] Finished read-buildbot-config step (success) 04:08:59 INFO - [mozharness: 2016-07-29 11:08:59.430524Z] Running download-and-extract step. 04:08:59 INFO - Running pre-action listener: _resource_record_pre_action 04:08:59 INFO - Running main action method: download_and_extract 04:08:59 INFO - mkdir: /builds/slave/test/build/tests 04:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:59 INFO - https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:09:07 INFO - Downloaded 1361 bytes. 04:09:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:09:07 INFO - Using the following test package requirements: 04:09:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:09:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:09:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:07 INFO - u'jsshell-linux-x86_64.zip'], 04:09:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:09:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:09:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:09:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:09:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:09:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:09: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')]} 04:09:07 INFO - https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:09:08 INFO - Downloaded 22749652 bytes. 04:09:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:09:09 INFO - Return code: 0 04:09:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:09 INFO - https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:09:12 INFO - Downloaded 22749652 bytes. 04:09:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:09:14 INFO - Return code: 0 04:09:14 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')]} 04:09:14 INFO - https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:09:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:09:15 INFO - Downloaded 14413725 bytes. 04:09:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:09:15 INFO - Return code: 0 04:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:15 INFO - https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:09:17 INFO - Downloaded 57169925 bytes. 04:09:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:17 INFO - mkdir: /builds/slave/test/properties 04:09:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:17 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:17 INFO - Contents: 04:09:17 INFO - build_url:https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:17 INFO - Running post-action listener: _resource_record_post_action 04:09:17 INFO - Running post-action listener: set_extra_try_arguments 04:09:17 INFO - [mozharness: 2016-07-29 11:09:17.819934Z] Finished download-and-extract step (success) 04:09:17 INFO - [mozharness: 2016-07-29 11:09:17.820258Z] Running populate-webroot step. 04:09:17 INFO - Running pre-action listener: _resource_record_pre_action 04:09:17 INFO - Running main action method: populate_webroot 04:09:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:17 INFO - '--tppagecycles', 04:09:17 INFO - '7'], 04:09:17 INFO - 'tests': ['tsvgm']}}, 04:09:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:09:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:09:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:09:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['damp', 'tps']}, 04:09:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'tests': ['damp', 'tps']}, 04:09:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['dromaeo_dom']}, 04:09:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['basic_compositor_video']}, 04:09:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:09:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore', 04:09:17 INFO - 'tabpaint']}, 04:09:17 INFO - 'other-e10s': {'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore', 04:09:17 INFO - 'tabpaint']}, 04:09:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore', 04:09:17 INFO - 'tabpaint']}, 04:09:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore', 04:09:17 INFO - 'tabpaint']}, 04:09:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore', 04:09:17 INFO - 'tabpaint']}, 04:09:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore', 04:09:17 INFO - 'tabpaint']}, 04:09:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['tsvgx', 04:09:17 INFO - 'tsvgr_opacity', 04:09:17 INFO - 'tart', 04:09:17 INFO - 'tscrollx', 04:09:17 INFO - 'cart']}, 04:09:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:09:17 INFO - 'tsvgr_opacity', 04:09:17 INFO - 'tart', 04:09:17 INFO - 'tscrollx', 04:09:17 INFO - 'cart']}, 04:09:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--disable-e10s'], 04:09:17 INFO - 'tests': ['tp5o']}, 04:09:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'tests': ['tp5o']}, 04:09:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--disable-e10s', 04:09:17 INFO - '--xperf_path', 04:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:17 INFO - 'tests': ['tp5n']}, 04:09:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--xperf_path', 04:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:17 INFO - 'tests': ['tp5n']}}, 04:09:17 INFO - 'talos.zip': {'path': '', 04:09:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:17 INFO - Running post-action listener: _resource_record_post_action 04:09:17 INFO - [mozharness: 2016-07-29 11:09:17.840389Z] Finished populate-webroot step (success) 04:09:17 INFO - [mozharness: 2016-07-29 11:09:17.840479Z] Running create-virtualenv step. 04:09:17 INFO - Running pre-action listener: _resource_record_pre_action 04:09:17 INFO - Running main action method: create_virtualenv 04:09:17 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:17 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 04:09:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:17 INFO - Using real prefix '/usr' 04:09:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:18 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:20 INFO - Installing pip.................done. 04:09:20 INFO - Return code: 0 04:09:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:09:20 INFO - Using env: {'DISPLAY': ':0', 04:09:20 INFO - 'HOME': '/home/cltbld', 04:09:20 INFO - 'LANG': 'en_US.UTF-8', 04:09:20 INFO - 'LANGUAGE': 'en_US:en', 04:09:20 INFO - 'LOGNAME': 'cltbld', 04:09:20 INFO - 'MAIL': '/var/mail/cltbld', 04:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:20 INFO - 'MOZ_NO_REMOTE': '1', 04:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:20 INFO - 'NO_EM_RESTART': '1', 04:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:20 INFO - 'PWD': '/builds/slave/test', 04:09:20 INFO - 'SHELL': '/bin/bash', 04:09:20 INFO - 'SHLVL': '1', 04:09:20 INFO - 'TERM': 'linux', 04:09:20 INFO - 'TMOUT': '86400', 04:09:20 INFO - 'USER': 'cltbld', 04:09:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:20 INFO - '_': '/tools/buildbot/bin/python'} 04:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:20 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 04:09:20 INFO - Cleaning up... 04:09:20 INFO - Return code: 0 04:09:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:09:20 INFO - Using env: {'DISPLAY': ':0', 04:09:20 INFO - 'HOME': '/home/cltbld', 04:09:20 INFO - 'LANG': 'en_US.UTF-8', 04:09:20 INFO - 'LANGUAGE': 'en_US:en', 04:09:20 INFO - 'LOGNAME': 'cltbld', 04:09:20 INFO - 'MAIL': '/var/mail/cltbld', 04:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:20 INFO - 'MOZ_NO_REMOTE': '1', 04:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:20 INFO - 'NO_EM_RESTART': '1', 04:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:20 INFO - 'PWD': '/builds/slave/test', 04:09:20 INFO - 'SHELL': '/bin/bash', 04:09:20 INFO - 'SHLVL': '1', 04:09:20 INFO - 'TERM': 'linux', 04:09:20 INFO - 'TMOUT': '86400', 04:09:20 INFO - 'USER': 'cltbld', 04:09:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:20 INFO - '_': '/tools/buildbot/bin/python'} 04:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:20 INFO - Downloading/unpacking psutil>=3.1.1 04:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:22 INFO - Installing collected packages: psutil 04:09:22 INFO - Running setup.py install for psutil 04:09:22 INFO - building 'psutil._psutil_linux' extension 04:09:22 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 04:09:23 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 04:09:23 INFO - building 'psutil._psutil_posix' extension 04:09:23 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 04:09:23 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 04:09:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:23 INFO - Successfully installed psutil 04:09:23 INFO - Cleaning up... 04:09:23 INFO - Return code: 0 04:09:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:09:23 INFO - Using env: {'DISPLAY': ':0', 04:09:23 INFO - 'HOME': '/home/cltbld', 04:09:23 INFO - 'LANG': 'en_US.UTF-8', 04:09:23 INFO - 'LANGUAGE': 'en_US:en', 04:09:23 INFO - 'LOGNAME': 'cltbld', 04:09:23 INFO - 'MAIL': '/var/mail/cltbld', 04:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:23 INFO - 'MOZ_NO_REMOTE': '1', 04:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:23 INFO - 'NO_EM_RESTART': '1', 04:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:23 INFO - 'PWD': '/builds/slave/test', 04:09:23 INFO - 'SHELL': '/bin/bash', 04:09:23 INFO - 'SHLVL': '1', 04:09:23 INFO - 'TERM': 'linux', 04:09:23 INFO - 'TMOUT': '86400', 04:09:23 INFO - 'USER': 'cltbld', 04:09:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:23 INFO - '_': '/tools/buildbot/bin/python'} 04:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:09:25 INFO - Installing collected packages: mozsystemmonitor 04:09:25 INFO - Running setup.py install for mozsystemmonitor 04:09:25 INFO - Successfully installed mozsystemmonitor 04:09:25 INFO - Cleaning up... 04:09:25 INFO - Return code: 0 04:09:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:09:25 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')]} 04:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:25 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')]} 04:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:25 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 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09:25 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 04:09:25 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 04:09:25 INFO - Using env: {'DISPLAY': ':0', 04:09:25 INFO - 'HOME': '/home/cltbld', 04:09:25 INFO - 'LANG': 'en_US.UTF-8', 04:09:25 INFO - 'LANGUAGE': 'en_US:en', 04:09:25 INFO - 'LOGNAME': 'cltbld', 04:09:25 INFO - 'MAIL': '/var/mail/cltbld', 04:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:25 INFO - 'MOZ_NO_REMOTE': '1', 04:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:25 INFO - 'NO_EM_RESTART': '1', 04:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:25 INFO - 'PWD': '/builds/slave/test', 04:09:25 INFO - 'SHELL': '/bin/bash', 04:09:25 INFO - 'SHLVL': '1', 04:09:25 INFO - 'TERM': 'linux', 04:09:25 INFO - 'TMOUT': '86400', 04:09:25 INFO - 'USER': 'cltbld', 04:09:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:25 INFO - '_': '/tools/buildbot/bin/python'} 04:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:09:27 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 04:09:27 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 04:09:27 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 04:09:27 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 04:09:27 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 04:09:27 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 04:09:27 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:28 INFO - warning: no files found matching '*.txt' 04:09:28 INFO - no previously-included directories found matching 'build' 04:09:28 INFO - no previously-included directories found matching 'dist' 04:09:28 INFO - no previously-included directories found matching '.git*' 04:09:28 INFO - Installing collected packages: jsonschema, functools32 04:09:28 INFO - Running setup.py install for functools32 04:09:28 INFO - warning: no files found matching '*.txt' 04:09:28 INFO - no previously-included directories found matching 'build' 04:09:28 INFO - no previously-included directories found matching 'dist' 04:09:28 INFO - no previously-included directories found matching '.git*' 04:09:28 INFO - Successfully installed jsonschema functools32 04:09:28 INFO - Cleaning up... 04:09:28 INFO - Return code: 0 04:09:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:28 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 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09:28 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 04:09:28 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 04:09:28 INFO - Using env: {'DISPLAY': ':0', 04:09:28 INFO - 'HOME': '/home/cltbld', 04:09:28 INFO - 'LANG': 'en_US.UTF-8', 04:09:28 INFO - 'LANGUAGE': 'en_US:en', 04:09:28 INFO - 'LOGNAME': 'cltbld', 04:09:28 INFO - 'MAIL': '/var/mail/cltbld', 04:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:28 INFO - 'MOZ_NO_REMOTE': '1', 04:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:28 INFO - 'NO_EM_RESTART': '1', 04:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:28 INFO - 'PWD': '/builds/slave/test', 04:09:28 INFO - 'SHELL': '/bin/bash', 04:09:28 INFO - 'SHLVL': '1', 04:09:28 INFO - 'TERM': 'linux', 04:09:28 INFO - 'TMOUT': '86400', 04:09:28 INFO - 'USER': 'cltbld', 04:09:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:28 INFO - '_': '/tools/buildbot/bin/python'} 04:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:09:28 INFO - Cleaning up... 04:09:28 INFO - Return code: 0 04:09:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:28 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 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09:28 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 04:09:28 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 04:09:28 INFO - Using env: {'DISPLAY': ':0', 04:09:28 INFO - 'HOME': '/home/cltbld', 04:09:28 INFO - 'LANG': 'en_US.UTF-8', 04:09:28 INFO - 'LANGUAGE': 'en_US:en', 04:09:28 INFO - 'LOGNAME': 'cltbld', 04:09:28 INFO - 'MAIL': '/var/mail/cltbld', 04:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:28 INFO - 'MOZ_NO_REMOTE': '1', 04:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:28 INFO - 'NO_EM_RESTART': '1', 04:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:28 INFO - 'PWD': '/builds/slave/test', 04:09:28 INFO - 'SHELL': '/bin/bash', 04:09:28 INFO - 'SHLVL': '1', 04:09:28 INFO - 'TERM': 'linux', 04:09:28 INFO - 'TMOUT': '86400', 04:09:28 INFO - 'USER': 'cltbld', 04:09:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:28 INFO - '_': '/tools/buildbot/bin/python'} 04:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:28 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:28 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 04:09:28 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 04:09:28 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 04:09:28 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 04:09:28 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 04:09:28 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 04:09:30 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:30 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 04:09:30 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 04:09:30 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 04:09:30 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 04:09:30 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 04:09:30 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 04:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:31 INFO - Downloading docopt-0.6.1.tar.gz 04:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:31 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:31 INFO - Running setup.py install for blobuploader 04:09:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:31 INFO - Running setup.py install for requests 04:09:31 INFO - Running setup.py install for docopt 04:09:31 INFO - Successfully installed blobuploader requests docopt 04:09:31 INFO - Cleaning up... 04:09:31 INFO - Return code: 0 04:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:31 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 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09:31 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 04:09:31 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 04:09:31 INFO - Using env: {'DISPLAY': ':0', 04:09:31 INFO - 'HOME': '/home/cltbld', 04:09:31 INFO - 'LANG': 'en_US.UTF-8', 04:09:31 INFO - 'LANGUAGE': 'en_US:en', 04:09:31 INFO - 'LOGNAME': 'cltbld', 04:09:31 INFO - 'MAIL': '/var/mail/cltbld', 04:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:31 INFO - 'MOZ_NO_REMOTE': '1', 04:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:31 INFO - 'NO_EM_RESTART': '1', 04:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:31 INFO - 'PWD': '/builds/slave/test', 04:09:31 INFO - 'SHELL': '/bin/bash', 04:09:31 INFO - 'SHLVL': '1', 04:09:31 INFO - 'TERM': 'linux', 04:09:31 INFO - 'TMOUT': '86400', 04:09:31 INFO - 'USER': 'cltbld', 04:09:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:31 INFO - '_': '/tools/buildbot/bin/python'} 04:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:32 INFO - Running setup.py (path:/tmp/pip-f6SrBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:32 INFO - Running setup.py (path:/tmp/pip-AAaO5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:32 INFO - Running setup.py (path:/tmp/pip-MSlk07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:32 INFO - Running setup.py (path:/tmp/pip-W14j5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:32 INFO - Running setup.py (path:/tmp/pip-RVTiJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:32 INFO - Running setup.py (path:/tmp/pip-YOiUtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:32 INFO - Running setup.py (path:/tmp/pip-WqqwrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:32 INFO - Running setup.py (path:/tmp/pip-6KdGFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:32 INFO - Running setup.py (path:/tmp/pip-yfPpw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:32 INFO - Running setup.py (path:/tmp/pip-7kl7tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:32 INFO - Running setup.py (path:/tmp/pip-xvs8eR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:32 INFO - Running setup.py (path:/tmp/pip-UbORWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:33 INFO - Running setup.py (path:/tmp/pip-Fc9pZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:33 INFO - Running setup.py (path:/tmp/pip-WQwW72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:33 INFO - Running setup.py (path:/tmp/pip-QLzIv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:33 INFO - Running setup.py (path:/tmp/pip-QIli_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:33 INFO - Running setup.py (path:/tmp/pip-XrGqrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:33 INFO - Running setup.py install for manifestparser 04:09:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:33 INFO - Running setup.py install for mozcrash 04:09:33 INFO - Running setup.py install for mozdebug 04:09:33 INFO - Running setup.py install for mozdevice 04:09:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:33 INFO - Running setup.py install for mozfile 04:09:33 INFO - Running setup.py install for mozhttpd 04:09:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:33 INFO - Running setup.py install for mozinfo 04:09:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Running setup.py install for mozInstall 04:09:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Running setup.py install for mozleak 04:09:34 INFO - Running setup.py install for mozlog 04:09:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Running setup.py install for moznetwork 04:09:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Running setup.py install for mozprocess 04:09:34 INFO - Running setup.py install for mozprofile 04:09:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Running setup.py install for mozrunner 04:09:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:34 INFO - Running setup.py install for mozscreenshot 04:09:34 INFO - Running setup.py install for moztest 04:09:35 INFO - Running setup.py install for mozversion 04:09:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:35 INFO - Cleaning up... 04:09:35 INFO - Return code: 0 04:09:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:35 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 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09:35 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 04:09:35 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 04:09:35 INFO - Using env: {'DISPLAY': ':0', 04:09:35 INFO - 'HOME': '/home/cltbld', 04:09:35 INFO - 'LANG': 'en_US.UTF-8', 04:09:35 INFO - 'LANGUAGE': 'en_US:en', 04:09:35 INFO - 'LOGNAME': 'cltbld', 04:09:35 INFO - 'MAIL': '/var/mail/cltbld', 04:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:35 INFO - 'MOZ_NO_REMOTE': '1', 04:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:35 INFO - 'NO_EM_RESTART': '1', 04:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:35 INFO - 'PWD': '/builds/slave/test', 04:09:35 INFO - 'SHELL': '/bin/bash', 04:09:35 INFO - 'SHLVL': '1', 04:09:35 INFO - 'TERM': 'linux', 04:09:35 INFO - 'TMOUT': '86400', 04:09:35 INFO - 'USER': 'cltbld', 04:09:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:35 INFO - '_': '/tools/buildbot/bin/python'} 04:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:35 INFO - Running setup.py (path:/tmp/pip-TBUWoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:35 INFO - Running setup.py (path:/tmp/pip-Oo8GQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:35 INFO - Running setup.py (path:/tmp/pip-uRP554-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:35 INFO - Running setup.py (path:/tmp/pip-EbFNVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:35 INFO - Running setup.py (path:/tmp/pip-18Wq_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:35 INFO - Running setup.py (path:/tmp/pip-k0uTiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:35 INFO - Running setup.py (path:/tmp/pip-RpmDJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:35 INFO - Running setup.py (path:/tmp/pip-HeybXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:35 INFO - Running setup.py (path:/tmp/pip-8AwLR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:36 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)) 04:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:36 INFO - Running setup.py (path:/tmp/pip-xVJmcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:36 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)) 04:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:36 INFO - Running setup.py (path:/tmp/pip-2AUFra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:36 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)) 04:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:36 INFO - Running setup.py (path:/tmp/pip-6RDDxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:36 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)) 04:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:36 INFO - Running setup.py (path:/tmp/pip-UwAVK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:36 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)) 04:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:36 INFO - Running setup.py (path:/tmp/pip-q0xEe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:36 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)) 04:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:36 INFO - Running setup.py (path:/tmp/pip-zOoWjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:36 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)) 04:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:36 INFO - Running setup.py (path:/tmp/pip-SbsGYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:36 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)) 04:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:36 INFO - Running setup.py (path:/tmp/pip-xtGfTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:36 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)) 04:09:36 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)) 04:09:36 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)) 04:09:36 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)) 04:09:36 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)) 04:09:36 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)) 04:09:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:36 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 04:09:36 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 04:09:36 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 04:09:36 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 04:09:36 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 04:09:36 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 04:09:38 INFO - Downloading blessings-1.6.tar.gz 04:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:38 INFO - Installing collected packages: blessings 04:09:38 INFO - Running setup.py install for blessings 04:09:38 INFO - Successfully installed blessings 04:09:38 INFO - Cleaning up... 04:09:38 INFO - Return code: 0 04:09:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:38 INFO - Reading from file tmpfile_stdout 04:09:38 INFO - Current package versions: 04:09:38 INFO - argparse == 1.2.1 04:09:38 INFO - blessings == 1.6 04:09:38 INFO - blobuploader == 1.2.4 04:09:38 INFO - docopt == 0.6.1 04:09:38 INFO - functools32 == 3.2.3-2 04:09:38 INFO - jsonschema == 2.5.1 04:09:38 INFO - manifestparser == 1.1 04:09:38 INFO - mozInstall == 1.12 04:09:38 INFO - mozcrash == 0.17 04:09:38 INFO - mozdebug == 0.1 04:09:38 INFO - mozdevice == 0.48 04:09:38 INFO - mozfile == 1.2 04:09:38 INFO - mozhttpd == 0.7 04:09:38 INFO - mozinfo == 0.9 04:09:38 INFO - mozleak == 0.1 04:09:38 INFO - mozlog == 3.3 04:09:38 INFO - moznetwork == 0.27 04:09:38 INFO - mozprocess == 0.23 04:09:38 INFO - mozprofile == 0.28 04:09:38 INFO - mozrunner == 6.12 04:09:38 INFO - mozscreenshot == 0.1 04:09:38 INFO - mozsystemmonitor == 0.3 04:09:38 INFO - moztest == 0.7 04:09:38 INFO - mozversion == 1.4 04:09:38 INFO - psutil == 3.1.1 04:09:38 INFO - requests == 1.2.3 04:09:38 INFO - wsgiref == 0.1.2 04:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:38 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')]} 04:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:38 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')]} 04:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:38 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 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09:38 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 04:09:38 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 04:09:38 INFO - Using env: {'DISPLAY': ':0', 04:09:38 INFO - 'HOME': '/home/cltbld', 04:09:38 INFO - 'LANG': 'en_US.UTF-8', 04:09:38 INFO - 'LANGUAGE': 'en_US:en', 04:09:38 INFO - 'LOGNAME': 'cltbld', 04:09:38 INFO - 'MAIL': '/var/mail/cltbld', 04:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:38 INFO - 'MOZ_NO_REMOTE': '1', 04:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:38 INFO - 'NO_EM_RESTART': '1', 04:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:38 INFO - 'PWD': '/builds/slave/test', 04:09:38 INFO - 'SHELL': '/bin/bash', 04:09:38 INFO - 'SHLVL': '1', 04:09:38 INFO - 'TERM': 'linux', 04:09:38 INFO - 'TMOUT': '86400', 04:09:38 INFO - 'USER': 'cltbld', 04:09:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:38 INFO - '_': '/tools/buildbot/bin/python'} 04:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:39 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)) 04:09:39 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)) 04:09:39 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)) 04:09:39 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)) 04:09:39 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)) 04:09:39 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)) 04:09:39 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)) 04:09:39 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)) 04:09:39 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)) 04:09:39 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)) 04:09:39 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)) 04:09:39 INFO - Cleaning up... 04:09:39 INFO - Return code: 0 04:09:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d68180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', '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 04:09: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', 'jsonschema'] in /builds/slave/test/build 04:09: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 jsonschema 04:09:39 INFO - Using env: {'DISPLAY': ':0', 04:09:39 INFO - 'HOME': '/home/cltbld', 04:09:39 INFO - 'LANG': 'en_US.UTF-8', 04:09:39 INFO - 'LANGUAGE': 'en_US:en', 04:09:39 INFO - 'LOGNAME': 'cltbld', 04:09:39 INFO - 'MAIL': '/var/mail/cltbld', 04:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:39 INFO - 'MOZ_NO_REMOTE': '1', 04:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:39 INFO - 'NO_EM_RESTART': '1', 04:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:39 INFO - 'PWD': '/builds/slave/test', 04:09:39 INFO - 'SHELL': '/bin/bash', 04:09:39 INFO - 'SHLVL': '1', 04:09:39 INFO - 'TERM': 'linux', 04:09:39 INFO - 'TMOUT': '86400', 04:09:39 INFO - 'USER': 'cltbld', 04:09:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:39 INFO - '_': '/tools/buildbot/bin/python'} 04:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:09:39 INFO - Cleaning up... 04:09:39 INFO - Return code: 0 04:09:39 INFO - Running post-action listener: _resource_record_post_action 04:09:39 INFO - Running post-action listener: _start_resource_monitoring 04:09:39 INFO - Starting resource monitoring. 04:09:39 INFO - [mozharness: 2016-07-29 11:09:39.445291Z] Finished create-virtualenv step (success) 04:09:39 INFO - [mozharness: 2016-07-29 11:09:39.445736Z] Running install step. 04:09:39 INFO - Running pre-action listener: _resource_record_pre_action 04:09:39 INFO - Running main action method: install 04:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:39 INFO - Reading from file tmpfile_stdout 04:09:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:39 INFO - Reading from file tmpfile_stdout 04:09:39 INFO - Output received: 04:09:39 INFO - Usage: mozinstall [options] installer 04:09:39 INFO - Options: 04:09:39 INFO - -h, --help show this help message and exit 04:09:39 INFO - -d DEST, --destination=DEST 04:09:39 INFO - Directory to install application into. [default: 04:09:39 INFO - "/builds/slave/test"] 04:09:39 INFO - --app=APP Application being installed. [default: firefox] 04:09:39 INFO - mkdir: /builds/slave/test/build/application 04:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:09:56 INFO - Reading from file tmpfile_stdout 04:09:56 INFO - Output received: 04:09:56 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:56 INFO - Running post-action listener: _resource_record_post_action 04:09:56 INFO - [mozharness: 2016-07-29 11:09:56.185693Z] Finished install step (success) 04:09:56 INFO - [mozharness: 2016-07-29 11:09:56.185971Z] Running run-tests step. 04:09:56 INFO - Running pre-action listener: _resource_record_pre_action 04:09:56 INFO - Running main action method: run_tests 04:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:56 INFO - Python 2.7.3 04:09:56 INFO - Return code: 0 04:09:56 INFO - grabbing minidump binary from tooltool 04:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:56 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 0x1d663b0>, '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 0x1d672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:56 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 04:09:56 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 04:09:56 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 04:09:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:56 INFO - Return code: 0 04:09:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 04:09:56 INFO - Using env: {'DISPLAY': ':0', 04:09:56 INFO - 'HOME': '/home/cltbld', 04:09:56 INFO - 'LANG': 'en_US.UTF-8', 04:09:56 INFO - 'LANGUAGE': 'en_US:en', 04:09:56 INFO - 'LOGNAME': 'cltbld', 04:09:56 INFO - 'MAIL': '/var/mail/cltbld', 04:09:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:56 INFO - 'MOZ_NO_REMOTE': '1', 04:09:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:56 INFO - 'NO_EM_RESTART': '1', 04:09:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:56 INFO - 'PWD': '/builds/slave/test', 04:09:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:56 INFO - 'SHELL': '/bin/bash', 04:09:56 INFO - 'SHLVL': '1', 04:09:56 INFO - 'TERM': 'linux', 04:09:56 INFO - 'TMOUT': '86400', 04:09:56 INFO - 'USER': 'cltbld', 04:09:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406', 04:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:56 INFO - '_': '/tools/buildbot/bin/python'} 04:09:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:09:56 INFO - mozversion application_buildid: 20160729025526 04:09:56 INFO - mozversion application_changeset: 4dc4d45c2115f8805f15e10c0bf0e776408af0d2 04:09:56 INFO - mozversion application_display_name: Nightly 04:09:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:56 INFO - mozversion application_name: Firefox 04:09:56 INFO - mozversion application_remotingname: firefox 04:09:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:09:56 INFO - mozversion application_vendor: Mozilla 04:09:56 INFO - mozversion application_version: 50.0a1 04:09:56 INFO - mozversion platform_buildid: 20160729025526 04:09:56 INFO - mozversion platform_changeset: 4dc4d45c2115f8805f15e10c0bf0e776408af0d2 04:09:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:09:56 INFO - mozversion platform_version: 50.0a1 04:09:56 INFO - using testdate: 1469790596 04:09:56 INFO - actual date: 1469790596 04:09:56 INFO - starting webserver on 'localhost:48761' 04:09:56 INFO - SUITE-START | Running 2 tests 04:09:56 INFO - TEST-START | dromaeo_css 04:09:56 INFO - operating with platform_type : linux_ 04:09:56 INFO - Initialising browser for dromaeo_css test... 04:09:56 INFO - TEST-INFO | started process 25283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_iCBth/profile http://localhost:48761/getInfo.html) 04:09:59 INFO - PROCESS | 25283 | JavaScript error: , line 0: uncaught exception: undefined 04:10:00 INFO - PROCESS | 25283 | __metrics Screen width/height:1600/1200 04:10:00 INFO - PROCESS | 25283 | colorDepth:24 04:10:00 INFO - PROCESS | 25283 | Browser inner width/height: 1024/697 04:10:00 INFO - PROCESS | 25283 | __metrics 04:10:01 INFO - PROCESS | 25283 | 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" 04:10:01 INFO - PROCESS | 25283 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:10:02 INFO - TEST-INFO | 25283: exit 0 04:10:02 INFO - Browser initialized. 04:10:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:02 INFO - TEST-INFO | started process 25364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_iCBth/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:14 INFO - PROCESS | 25364 | RSS: Main: 159170560 04:10:14 INFO - PROCESS | 25364 | 04:11:05 INFO - PROCESS | 25364 | 1469790665711 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] 04:13:17 INFO - PROCESS | 25364 | Cycle 1(1): loaded http://localhost:48761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48761/tests/dromaeo/cssquery-ext.html) 04:13:18 INFO - PROCESS | 25364 | RSS: Main: 236847104 04:13:18 INFO - PROCESS | 25364 | 04:16:21 INFO - PROCESS | 25364 | Cycle 1(1): loaded http://localhost:48761/tests/dromaeo/cssquery-ext.html (next: http://localhost:48761/tests/dromaeo/cssquery-jquery.html) 04:16:21 INFO - PROCESS | 25364 | RSS: Main: 239628288 04:16:21 INFO - PROCESS | 25364 | 04:19:24 INFO - PROCESS | 25364 | Cycle 1(1): loaded http://localhost:48761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48761/tests/dromaeo/cssquery-mootools.html) 04:19:24 INFO - PROCESS | 25364 | RSS: Main: 190734336 04:19:24 INFO - PROCESS | 25364 | 04:22:27 INFO - PROCESS | 25364 | Cycle 1(1): loaded http://localhost:48761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48761/tests/dromaeo/cssquery-prototype.html) 04:22:27 INFO - PROCESS | 25364 | RSS: Main: 189427712 04:22:27 INFO - PROCESS | 25364 | 04:25:30 INFO - PROCESS | 25364 | Cycle 1(1): loaded http://localhost:48761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48761/tests/dromaeo/cssquery-yui.html) 04:25:31 INFO - PROCESS | 25364 | RSS: Main: 192106496 04:25:31 INFO - PROCESS | 25364 | 04:28:34 INFO - PROCESS | 25364 | Cycle 1(1): loaded http://localhost:48761/tests/dromaeo/cssquery-yui.html (next: http://localhost:48761/tests/dromaeo/cssquery-dojo.html) 04:28:34 INFO - PROCESS | 25364 | RSS: Main: 282533888 04:28:34 INFO - PROCESS | 25364 | 04:28:34 INFO - PROCESS | 25364 | __start_tp_report 04:28:34 INFO - PROCESS | 25364 | _x_x_mozilla_page_load 04:28:34 INFO - PROCESS | 25364 | _x_x_mozilla_page_load_details 04:28:34 INFO - PROCESS | 25364 | |i|pagename|runs| 04:28:34 INFO - PROCESS | 25364 | |0;dojo.html;2639.234621959632;2639.458910923261;2670.2389818901606;2674.157640343291;2677.5314319993995;4592.402987611614;4651.651126165534;4723.480417154115;4842.128416884963;4846.539578740018;4702.835400760974;4738.810447582093;4750.121227572901;4768.52314768523;4827.468978412372;4322.092360604277;4354.042110735633;4368.49762277339;4400.911981760363;4521.932171017437;4421.182081314951;4464.910701785962;4478.417805685256;4495.685302028859;4496.752678602676;4259.041715613993;4382.189294980407;4383.868483945486;4441.844535441261;4466.731996080245;4305.354196870463;4313;4327.221100201962;4360.49854266757;4386.517483076859;4303.07483890965;4314.050908800059;4360.978195109036;4373.190959672471;4407.008423104808;4694.976525117387;4764.785584648699;4812.759362031919;4818.180909245437;4822.565969062766;4874.829380971684;5022.372203474566;5046.318746969149;5065.366829146356;5150.716710580917;5094.363204599425;5107.3360463139925;5148.5623721983675;5151.6908985461;5159.638825282232;4808.471068182497;4810.518948105197;4812.037592481448;4814.614830813526;4814.831480898151;5035.521625445577;5131.897362052738;5155.74221288934;5192.844214673566;5232.084385232569;4996.125678006334;5036;5047.4447810740785;5047.9495205048215;5051.191809310492;5078.111330517218;5081.339425874613;5085.542301192911;5135.35808023997;5143.305653736773;4820.590249828804;4837.9032419351415;4915.992221594564;4918.163912134945;4981.576565991859;4888.6577939543895;4904.166291730415;4908.656394052454;4940.011997600423;4957.281194226817;4198.223328684203;4202.663786897041;4205.558416366299;4238.766867822238;4247.384129301234;3667.4865518827387;3668.3396988541786;3673.522442082512;3719.5536535615897;3723.069232691827;4375.059362237071;4422.469303683514;4422.867313980586;4452.398926144993;4491.842785502492;5132;5137.255098010843;5138.820141295037;5141.126008578551;5195.48045195485;4235.216484950232;4399.450068741407;4444.066745983315;4449.421575195204;4490.640748740093;4525.162844873709;4537.977310113494;4549.226631472658;4570.840020599329;4612.30815377696;4821.855344339676;4830.7101573905675;4831.685940413932;4831.73425461603;4873.926891096708;4937.5556199942175;5073.416557095834;5087.3132127163835;5105.566026887607;5146.073706732824;4751.334813126096;4774.809007639795;4785.449673287617;4788.353572267699;4853;4992.975035124801;4997.675151115166;5006.249062640633;5010.348654674869;5059.46875578059;4886.975565122151;5061.898762024813;5074.822381216787;5075.695458272516;5127.615428842777;4867.123917694849;4895.632827537877;4902.681325713817;4930.211166213532;4952.207646776643;4941.728204948762;4953.083679519156;4954.380702412199;4956.752162391938;5002.699838009731;4730.1958667026;4863.221884498464;4864;4917.213245880642;4921.8523444296725;4931.284963680175;4931.753412329441;4979.800807967641;4993.875153121201;5010.972750586194;4872.634552408513;4878.707277563358;4885.926711099265;4894.216925291937;4937.23472861707 04:28:34 INFO - PROCESS | 25364 | |1;ext.html;566.9829905102847;577.5264283287703;589.9764009439623;596.7791916990711;601.7773423833177;26653.73346266539;38286.42570361443;39380.409293860546;39579.604203957984;44105.55894441055;40104.39843402351;40617;40647;40665;40717.38923916136;7578.090629124499;7708.11356693979;7713.652885620132;7728.459007869451;7796.688132474695;7559.773206803778;7612.657430415645;7614.352780013678;7637.656305466239;7647.044119485065;7658.425618078639;7678.846423071535;7694.884576731325;7701.191374905638;7702.499337543042;7591.620418979029;7635.6563954621615;7646.770596882075;7684.615769211573;7697.2302769722855;7750.069991600988;7821.687132514692;7822.061352637663;7824.530528168328;7827.178146294671;37590;38082.42876356857;38117;38206.80896595527;38640.42039369412;3000.4749168895573;3008.1877892968996;3095.2880837407297;3100.860461279225;3264.265540253424;28144.718552814415;28204.294892627644;28209.294767630974;28563.285917852012;29337.85331073331;3073.569700241968;3109.5024796032526;3115.9376812463624;3146.921326966821;3217.1635374802486;183716.08141959205;184189;184571.07714461343;185213.0739346308;185502;53069.469305306455;53337.73331133319;53413.06228157411;53441.198382024304;53463.46536534662;32497;33196.50205246923;33254.83372583122;35511.644883550834;35517;15619.921900390425;15814;15821.841781582038;15824.604384890239;15833.841661583238;11892.524299027942;11955.64133076009;11958.40207989597;11968.880311196777;11973.46119424628;18050.1877415514;18127.72808407875;18131.274749010157;18295.359662411753;18326.083695815156;6655.534112612071;6808.795736127924;6947;6949.131358580177;6972.574208468067;790.3124281874691;855.8416692911832;864.4726716702806;866.3242670716851;888.2183678362999;27593.310167245578;27687.584686229722;27993.160205193875;28201.028951077576;28422.573661395094;775.4223103787714;962.3936919740659;989.1938070472542;1016.8373060310315;1029.2229366827996;14798.92600537012;15096.773548396563;15109.093454392772;15243.923780381027;15280.617984550476;184231;613397;624219;628467.8649101335;630832;48740.51259487431;49375.25937110946;49422.50577494179;49422.752886236056;49422.752886236056;1072.367303291062;1103.448275862069;1179.3042105157826;1203.8555373355252;1204.3797444316185;26072.478550429263;28867.885148633402;29005;31542.842285789342;31624.209394765316;46581;47348.52651473441;47357.289640656105;47376;47422.525774741815;341438;342717;343498;344693;347886;24366.75633243716;24749.133780317603;26487.735122648526;27039.594406084318;27461.86269068722;41262.1747565053;41527.792361038;41537.1692566153;41557.37663935104;41740.58259417367;34712.652873471954;35065.64934350624;35161.47257791084;35437.645623544464;35448.82275588605;35394.46908296429;35511.644883550834;35811.64188358083;35948.10129746777;36068.4589731149;35081;35131;35727.82136089407;35874.64125358713;35958;30602.84698576493;32585.34829303448;32744;32806;32811.83594082014;24415.145469908468;24499.142530011362;24819.503609928062;25148.62277065882;25257.242282731546 04:28:34 INFO - PROCESS | 25364 | |2;jquery.html;330.51414420801416;348.7889826654872;349.21601005742104;357.51735157537314;358.3853690920072;12832.294223817686;16114.35542578297;16548.66902661946;17170.39903603374;17953.64092718145;17302.56743581408;17302.913485432586;17331.653366932685;17656.646867062653;17800.910995445036;4916.827911023097;4928.630352723551;5030.773615187307;5062.696238225718;5075.6447048706605;3779.130799916007;4891.290762839386;4972.950270497285;5684.602077854552;5984.970075149618;5878.5297176225795;5899.174115623795;5903.291605007405;5911.231539899807;5912.852178695545;5060.493950604947;5284.81503147388;5321.866953326159;5408.432114627947;5901.203337549418;5229.529342359206;5246.895062098775;5260.684358938438;5269.947300527022;5270.446603106657;12281.201721888137;12398.380080995914;12521.311327876963;12584.182028168232;12646.873531264662;1758.4900378890106;1808.6021075363399;1863.236073209991;2011.1151093518804;2163.350994701599;8787.25308348791;8949.105089491064;8994.145556172152;9445.197158241557;9641.132298093135;1721.9655606887918;1725.930962761488;1728.5937804615905;1792.6773180827445;1818.163644723429;69379.71512991164;71473.64263178704;72931;74131;76327.23672763257;9857.211423086279;9935.503224838729;9936.80126397468;10172.237082218864;10605.628802991858;13481.056326057278;13482.730345393038;13519.459221631221;13521.729565408834;13522.25627590492;7403.8149046274275;7542.962285188539;7627.122880868771;7727.1886451922865;7818.960905195438;7305.707771689073;7380.630968451556;7410.814729631802;7602.50583712057;7611.923880761232;4275.508316543575;4327.6970612057485;4329.523752387235;4329.675274354436;4451.888702782391;1706.3601149568913;1783.2599471219557;1797.3475747202183;1801.7567628370264;1839.41138835574;378.50982977044794;387.413069200162;391.98236079376494;406.5710675237594;758.2417582417582;10623.256372054037;10631.308964917256;10957.561697532168;11056.723581910355;11267.830982535268;388.86645428575383;408.82829211731143;415.91265834175164;427.1478400590779;439.1042273761491;5665.716714164275;5721.284839395075;5835;5842.152887831326;6028.065649824284;361100;399282;408437;409658;409908;82390.43983933236;82607.5869620648;83065;84195;87793;436.7030419314833;438.7586827245066;439.45068664169787;440.70913197289633;444.3579028304134;10014.449205293779;10078.798424031625;10113.848292275768;10216.438095904796;10459.68620941373;34453;37437.4384384229;38583;39190.60809391984;39539.604603954744;43939.78030109829;51331.74334128306;51590.226146608584;51661.48338516717;53186;7655;7758.185390534139;7790.259925307087;7947.960260198662;8144.714934977247;11283;12168.634940951786;12203.938980305042;12269.509219631114;12620.116591838483;10360.222983276435;10366.326188797704;10552.525136369035;10850.511726972147;11117.555297788322;5154.304168937146;7483.476156668981;10674.452204430469;10693.09108725767;10800.189985750943;10050.09549140581;10446.216533759847;10557.472126393803;10696;10698.358098514114;7691.461597688108;7719.575423351769;7821.374290056896;7979.441439099207;8045.316148127475;8874.378793484653;10196.3372380795;10371;10441.373517588665;10835.67492975212 04:28:34 INFO - PROCESS | 25364 | |3;mootools.html;1213.3387303919362;1319.4985905355963;1378.8552202018789;1408.9788653170203;1678.0602862397059;6437.259715132755;7334.779956601304;7548.849023019543;7607.7717668469895;7882.054153501574;7711.267429594193;7761.767146985585;7770.4172187085915;7780.92219077809;7786.182450842665;2165.1123039553827;2189.8029177374033;2190.211523851412;2190.9233176838816;2191.6274233380364;2099.2337796704246;2122.5330427305967;2217.556488702258;2221.1670623516184;2222.1666874921902;2167.6856855755905;2179.7057397251406;2185.7158569385956;2189.901454434554;2216.6674998750154;2156.3962090614655;2158.0504577985635;2159.2334721173916;2160.2331172433796;2161;2104.0847231454213;2145.8819764912923;2147.5168087180414;2159.66525188596;2167.5989941860807;7727.420443466706;7769.339606133485;7819.0617125945255;7829.64766585505;7831.490953088031;4524.479684836253;4671.672982891199;4701.365315682373;4788.4253889533475;4789.137955168068;2860.3850172213074;2965.8368789716556;2983.209449495885;2993.6108305920093;3012.683668214828;877.9736607901773;888.706726780161;894.4633220067972;896.8475359188953;914.9130832570895;10256.94871525645;10259.17926565873;10304.124149447305;10358.53386597605;10376.273660843744;3779.905502362463;4016.477857878457;4077.7145599807727;4090.5295890972325;4112.157007813451;8330.791730206793;8338.374621903382;8346.582670866554;8346.791330216793;8356.791080223044;4621.768911554409;4621.861344159681;4623.606993405599;4625.699329543569;4636.698614590041;3668.1563240454843;3743.1016556026357;4190.958090419057;4277.294246449301;4301.032267739796;3306.123877172503;3316.6185888622636;3398.8300584970652;3466.1681196512654;3490.214701692099;997.187292356727;1030.1501261459325;1035.2028937717914;1044.7127040063892;1053.694428615693;678.8235058884726;800.8518424091561;809.1059379385812;815.1807433529265;821.4578378270313;5071.46749591295;5106.821261255838;5169.948300517022;5212.348456442945;5402.243685883979;840.4537050916953;866.4844417571535;870.1646419437285;889.9110088991179;915.3318077803108;3413.197898493852;3613;3618.782873027627;3633.5821380541047;3796.7532110413285;9339.486328252011;9560.378575392577;9680.951595241979;9696.224302055818;9715.417074975525;9619;9624.951875240578;9645.614175432904;9651.276154288456;9665.371750836313;7180.605066721276;7222.09723784527;7278.163011253668;7397.112346518452;7405.8889116663295;4955.5044495550155;5055.823046193365;5069.518395752398;5175.508326708957;5196.584273258206;8691.261242794433;8754.124587541195;8817.382783205114;8826.867596985921;8935.061818508962;8467.57662116904;8922.420042697204;8959.641614335354;8981.101889810967;9001.144891235323;5940.762369505172;6332.493400528039;6412.326705695835;6648.966755166193;6650.268470468342;7133.2153463117975;7400.555966642019;7414.666340014604;7420.740274090381;7425.368843648134;6490.286068532552;6490.513211509061;6665.866682666417;6714.328567143247;6811.557248778813;6297.590656607306;6435.03474478832;6582.637954912334;6740.797776066725;6766.424853887278;6173.783917562864;6272;6274.341194174546;6275.152854364603;6279.623222606659;4357.847475338348;4432.955670443254;4468.262736648417;4546.795394207203;4600.07998400328;4276.87169384919;4452.710573812692;4495.887602809825;4518.774061296987;4536.954630453653 04:28:34 INFO - PROCESS | 25364 | |4;prototype.html;299.8365890589629;302.9833359165245;305.6897249291968;312.4251377465463;313.67377926955965;4911.680740751849;4938;4956.826511072113;4960.776765045577;5001.499550134963;4864.294677271793;4908.705477671342;4919.877003074916;4920.458749537548;4923.975380123104;3895.7272990890647;3910.9413358799643;3913.8043097845134;3918.2751191029606;3929.9410508842248;3774.867539738081;3816.7709937403843;3846.326892793764;3915.6084391560903;3924.8037598120122;3795.4496597993275;3805.923881522368;3820.36963900956;3823.541175058997;3824.1778017726183;3775.6413140751583;3790.7915064671433;3798.240351929625;3803.6006219347123;3806.8667596634123;3194.7284480819158;3264.9673503264903;3276.705096541299;3336.51620515024;3346.598408191033;4685.508021657711;4689.50760170184;4701.130290896161;4708.882277943045;4709.317149013374;4331.935020974656;4332.913341733148;4337.587929146726;4337.674674399401;4341.934870976938;4781.784819683123;4795.376601041877;5045.612456574471;5065.4174769901565;5092.872678183038;3716;3717.962820371789;3720.7303544837628;3726.571444283915;3733.4213196954242;5294.205869119624;5308.230306605559;5318.521333080042;5329.25390445338;5331.333583302087;3695.9076023099637;3726.9440958385103;3771.8868433947027;3814.389697648363;3820.503334566489;3882.7282090253975;3883.8446462141765;3890.1636148228267;3893.9415908761393;3902.9804850975565;4377.584129507692;4384.298512238027;4388.780560971939;4391.956080439155;4399.582039706287;4838.927416088762;5147.378575748628;5156.716380599028;5175.482451754794;5176.378834539804;1261.8359613250402;1273.745360819592;1283.6854970532092;1283.8459384873875;1290.451558087809;804.1596531624466;825.3108654273749;835.9968038354;840.2269911681268;840.9957950210332;4082.2856000199845;4088.264112459726;4097.385392191195;4105.2405305018665;4138.772367519755;4652;4652.953470465252;4664.667666166916;4678.298255261738;4704.764761761899;4096.938545921814;4101.712880098424;4106.815193316308;4109.137081212919;4122.484689413824;2496.9649735465537;2589.0970136949327;2777.527820270559;2806.789490788199;2809.283632673696;4770.356001939694;4875.43932447773;4881.707097574157;4893.681910675795;4897;5237.16205407133;5370.892582148414;5411.242426060355;5419.34967803866;5424.918626220609;4838.637102217277;5018.372703412074;5027.245913113063;5028.296038554606;5033.496650335011;5261.500157485033;5276.023935571931;5279.8680032997945;5288.603354748332;5296.179092240709;5158.793648254028;5167.405748338839;5175.301334319969;5179.948200517946;5180.197069454241;4812.807487700453;5003.724795136157;5007.774650140679;5008.499150085108;5010.824621138243;3702.407614781622;3721.423179407196;3723.218124193841;3724.459953306701;3724.851005959731;5197.7141257229705;5236.89526209466;5240.161574148118;5254.5533629641905;5281.260623512634;4863.659543832039;5120.436751957207;5135.998480296306;5143.537081662668;5155.896882062413;5097.592192624507;5110.514501122388;5122.308488354024;5123.282740416419;5127.820526281712;5015.022070696179;5022.673526220784;5024.196128619404;5032.7483625819295;5051.974740126276;4902.583280421061;5085.160948443466;5124.871878203075;5135.5078546588675;5139.460356662496;5011.624128190328;5022.799088036438;5032.521910418504;5039.370078740158;5041.621878359211 04:28:34 INFO - PROCESS | 25364 | |5;yui.html;578.6499168003355;593.3859901069092;609.5002098279413;662.0863208771895;663.2273401487267;11701.473433695483;12259.08056895734;12554.623361299164;12560.560380386689;12750.744985100293;12116.757664846698;12432;12456.439460224288;12473.37633118345;12475.251484910888;626.3548544998636;749.8050506868212;769.0847891009709;771.9382449404034;772.5133166105373;733.3216774483608;757.9696812127509;759.0587671287591;760.8706519891632;760.9315161635452;794.2613369566301;797.1510341486328;799.5083023940293;799.6961154761183;799.7001124578284;644.8871447496716;794.7099308752322;794.940379471539;794.9761507154794;795.6459375577899;569.4476357932798;583.76941108262;584.6170758153417;585.8154681275385;586.2203269651353;12287.815682764765;12318;12329.630111096682;12356.073294502858;12358.134930554776;11576.363300018496;11764.176507644468;11889.28664280146;11959.103067269902;12193.817092743617;11166.441677916153;11268.774624507547;11291.604793832259;11334.489947952361;11421.086313094933;3979.507322710069;3996.320625493644;4034.3545032794614;4052.5947405259535;4188.748675079505;61852.38147618511;61976.38023619751;62107.378926211066;62186.68906655483;62207;9241;9375.437473751597;9406.200472959876;9497.240220782322;9528.666496672584;17119.14404279781;17166.22751976164;17268;17424.5643858902;17514.737278940825;5994.460498555151;6100.328963813977;6217.875642487215;6267.2792628847355;6447.2907980122145;3555.5022296878456;3564.6435356464144;3582.1940063486027;3603.621619729943;3609.4224924012033;2621.9606705899428;2686.529857274969;2706.580480025599;2741.4105967217142;2743.1222008957343;481.4944308476086;483.2461360277978;489.3662706794709;501.633807320658;507.31259143860274;462.6275847942439;487.2642310111757;524.7061645478544;557.275541795664;558.1934105217921;7238;7433.10802703679;7544.6227688616445;7609.505382150142;7859.84280314402;486.35315031008673;553.4520824383831;569.7720911635379;575.3412342867477;588.4145275450953;3828.1386687994977;3909.276783795007;3924.430957511202;3936.566977632458;4016.55817860041;52271.73864130655;52291.47708522866;75300;101262;101543;78965.21034789579;81047;81069;81305.18694813094;82293.58853205695;54991.45008549863;73013.63493182606;74174.03303867785;75355.62322188464;77597;7406.18531961473;7455.552666840007;7605.46761726696;7668.240908506006;7772.417068719982;42789;44043.779781100886;44176.77911610421;44299;44542.55457445384;57067;58014;60578;64445;65134;8937.150970658036;9154.26765858743;9347.252219822534;9662.806743865223;10318.071373576415;10342.844857327296;10363.792724145625;10695.5187016586;11001.61494347694;11004.889951100387;9512.476813775032;11167.218294719292;11728;12054.156209065632;12717.745645087232;10981.890181098406;11177.88822111801;11658.53365865356;12072.396380181131;12091.697707557381;11197.776044478902;11674.76650467003;12195.390230488618;12250.264984100982;12594.118411711092;9617.2306215504;9713.757156071155;9876;10196.235282354002;10263.178945684476;8848.778780530538;8875.33434992391;9596.280278978966;9685.951570242103;9789.167920726533 04:28:34 INFO - PROCESS | 25364 | __end_tp_report 04:28:34 INFO - PROCESS | 25364 | __start_cc_report 04:28:34 INFO - PROCESS | 25364 | _x_x_mozilla_cycle_collect,1103 04:28:34 INFO - PROCESS | 25364 | __end_cc_report 04:28:34 INFO - PROCESS | 25364 | __startTimestamp1469791714296__endTimestamp 04:28:34 INFO - PROCESS | 25364 | 04:28:34 INFO - PROCESS | 25364 | ------- Summary: start ------- 04:28:34 INFO - PROCESS | 25364 | Number of tests: 6 04:28:34 INFO - PROCESS | 25364 | 04:28:34 INFO - PROCESS | 25364 | [#0] dojo.html Cycles:165 Average:4689.67 Median:4831.73 stddev:490.16 (10.1%) stddev-sans-first:464.52 04:28:34 INFO - PROCESS | 25364 | Values: 2639.2 2639.5 2670.2 2674.2 2677.5 4592.4 4651.7 4723.5 4842.1 4846.5 4702.8 4738.8 4750.1 4768.5 4827.5 4322.1 4354.0 4368.5 4400.9 4521.9 4421.2 4464.9 4478.4 4495.7 4496.8 4259.0 4382.2 4383.9 4441.8 4466.7 4305.4 4313.0 4327.2 4360.5 4386.5 4303.1 4314.1 4361.0 4373.2 4407.0 4695.0 4764.8 4812.8 4818.2 4822.6 4874.8 5022.4 5046.3 5065.4 5150.7 5094.4 5107.3 5148.6 5151.7 5159.6 4808.5 4810.5 4812.0 4814.6 4814.8 5035.5 5131.9 5155.7 5192.8 5232.1 4996.1 5036.0 5047.4 5047.9 5051.2 5078.1 5081.3 5085.5 5135.4 5143.3 4820.6 4837.9 4916.0 4918.2 4981.6 4888.7 4904.2 4908.7 4940.0 4957.3 4198.2 4202.7 4205.6 4238.8 4247.4 3667.5 3668.3 3673.5 3719.6 3723.1 4375.1 4422.5 4422.9 4452.4 4491.8 5132.0 5137.3 5138.8 5141.1 5195.5 4235.2 4399.5 4444.1 4449.4 4490.6 4525.2 4538.0 4549.2 4570.8 4612.3 4821.9 4830.7 4831.7 4831.7 4873.9 4937.6 5073.4 5087.3 5105.6 5146.1 4751.3 4774.8 4785.4 4788.4 4853.0 4993.0 4997.7 5006.2 5010.3 5059.5 4887.0 5061.9 5074.8 5075.7 5127.6 4867.1 4895.6 4902.7 4930.2 4952.2 4941.7 4953.1 4954.4 4956.8 5002.7 4730.2 4863.2 4864.0 4917.2 4921.9 4931.3 4931.8 4979.8 4993.9 5011.0 4872.6 4878.7 4885.9 4894.2 4937.2 04:28:34 INFO - PROCESS | 25364 | 04:28:34 INFO - PROCESS | 25364 | [#1] ext.html Cycles:180 Average:49950.07 Median:35511.64 stddev:106496.90 (299.9%) stddev-sans-first:106731.10 04:28:34 INFO - PROCESS | 25364 | Values: 567.0 577.5 590.0 596.8 601.8 26653.7 38286.4 39380.4 39579.6 44105.6 40104.4 40617.0 40647.0 40665.0 40717.4 7578.1 7708.1 7713.7 7728.5 7796.7 7559.8 7612.7 7614.4 7637.7 7647.0 7658.4 7678.8 7694.9 7701.2 7702.5 7591.6 7635.7 7646.8 7684.6 7697.2 7750.1 7821.7 7822.1 7824.5 7827.2 37590.0 38082.4 38117.0 38206.8 38640.4 3000.5 3008.2 3095.3 3100.9 3264.3 28144.7 28204.3 28209.3 28563.3 29337.9 3073.6 3109.5 3115.9 3146.9 3217.2 183716.1 184189.0 184571.1 185213.1 185502.0 53069.5 53337.7 53413.1 53441.2 53463.5 32497.0 33196.5 33254.8 35511.6 35517.0 15619.9 15814.0 15821.8 15824.6 15833.8 11892.5 11955.6 11958.4 11968.9 11973.5 18050.2 18127.7 18131.3 18295.4 18326.1 6655.5 6808.8 6947.0 6949.1 6972.6 790.3 855.8 864.5 866.3 888.2 27593.3 27687.6 27993.2 28201.0 28422.6 775.4 962.4 989.2 1016.8 1029.2 14798.9 15096.8 15109.1 15243.9 15280.6 184231.0 613397.0 624219.0 628467.9 630832.0 48740.5 49375.3 49422.5 49422.8 49422.8 1072.4 1103.4 1179.3 1203.9 1204.4 26072.5 28867.9 29005.0 31542.8 31624.2 46581.0 47348.5 47357.3 47376.0 47422.5 341438.0 342717.0 343498.0 344693.0 347886.0 24366.8 24749.1 26487.7 27039.6 27461.9 41262.2 41527.8 41537.2 41557.4 41740.6 34712.7 35065.6 35161.5 35437.6 35448.8 35394.5 35511.6 35811.6 35948.1 36068.5 35081.0 35131.0 35727.8 35874.6 35958.0 30602.8 32585.3 32744.0 32806.0 32811.8 24415.1 24499.1 24819.5 25148.6 25257.2 04:28:34 INFO - PROCESS | 25364 | 04:28:34 INFO - PROCESS | 25364 | [#2] jquery.html Cycles:180 Average:24159.00 Median:205161.96 stddev:66045.16 (32.2%) stddev-sans-first:66206.20 04:28:34 INFO - PROCESS | 25364 | Values: 330.5 348.8 349.2 357.5 358.4 12832.3 16114.4 16548.7 17170.4 17953.6 17302.6 17302.9 17331.7 17656.6 17800.9 4916.8 4928.6 5030.8 5062.7 5075.6 3779.1 4891.3 4973.0 5684.6 5985.0 5878.5 5899.2 5903.3 5911.2 5912.9 5060.5 5284.8 5321.9 5408.4 5901.2 5229.5 5246.9 5260.7 5269.9 5270.4 12281.2 12398.4 12521.3 12584.2 12646.9 1758.5 1808.6 1863.2 2011.1 2163.4 8787.3 8949.1 8994.1 9445.2 9641.1 1722.0 1725.9 1728.6 1792.7 1818.2 69379.7 71473.6 72931.0 74131.0 76327.2 9857.2 9935.5 9936.8 10172.2 10605.6 13481.1 13482.7 13519.5 13521.7 13522.3 7403.8 7543.0 7627.1 7727.2 7819.0 7305.7 7380.6 7410.8 7602.5 7611.9 4275.5 4327.7 4329.5 4329.7 4451.9 1706.4 1783.3 1797.3 1801.8 1839.4 378.5 387.4 392.0 406.6 758.2 10623.3 10631.3 10957.6 11056.7 11267.8 388.9 408.8 415.9 427.1 439.1 5665.7 5721.3 5835.0 5842.2 6028.1 361100.0 399282.0 408437.0 409658.0 409908.0 82390.4 82607.6 83065.0 84195.0 87793.0 436.7 438.8 439.5 440.7 444.4 10014.4 10078.8 10113.8 10216.4 10459.7 34453.0 37437.4 38583.0 39190.6 39539.6 43939.8 51331.7 51590.2 51661.5 53186.0 7655.0 7758.2 7790.3 7948.0 8144.7 11283.0 12168.6 12203.9 12269.5 12620.1 10360.2 10366.3 10552.5 10850.5 11117.6 5154.3 7483.5 10674.5 10693.1 10800.2 10050.1 10446.2 10557.5 10696.0 10698.4 7691.5 7719.6 7821.4 7979.4 8045.3 8874.4 10196.3 10371.0 10441.4 10835.7 04:28:34 INFO - PROCESS | 25364 | 04:28:34 INFO - PROCESS | 25364 | [#3] mootools.html Cycles:180 Average:5038.92 Median:5186.05 stddev:2818.22 (54.3%) stddev-sans-first:2811.46 04:28:34 INFO - PROCESS | 25364 | Values: 1213.3 1319.5 1378.9 1409.0 1678.1 6437.3 7334.8 7548.8 7607.8 7882.1 7711.3 7761.8 7770.4 7780.9 7786.2 2165.1 2189.8 2190.2 2190.9 2191.6 2099.2 2122.5 2217.6 2221.2 2222.2 2167.7 2179.7 2185.7 2189.9 2216.7 2156.4 2158.1 2159.2 2160.2 2161.0 2104.1 2145.9 2147.5 2159.7 2167.6 7727.4 7769.3 7819.1 7829.6 7831.5 4524.5 4671.7 4701.4 4788.4 4789.1 2860.4 2965.8 2983.2 2993.6 3012.7 878.0 888.7 894.5 896.8 914.9 10256.9 10259.2 10304.1 10358.5 10376.3 3779.9 4016.5 4077.7 4090.5 4112.2 8330.8 8338.4 8346.6 8346.8 8356.8 4621.8 4621.9 4623.6 4625.7 4636.7 3668.2 3743.1 4191.0 4277.3 4301.0 3306.1 3316.6 3398.8 3466.2 3490.2 997.2 1030.2 1035.2 1044.7 1053.7 678.8 800.9 809.1 815.2 821.5 5071.5 5106.8 5169.9 5212.3 5402.2 840.5 866.5 870.2 889.9 915.3 3413.2 3613.0 3618.8 3633.6 3796.8 9339.5 9560.4 9681.0 9696.2 9715.4 9619.0 9625.0 9645.6 9651.3 9665.4 7180.6 7222.1 7278.2 7397.1 7405.9 4955.5 5055.8 5069.5 5175.5 5196.6 8691.3 8754.1 8817.4 8826.9 8935.1 8467.6 8922.4 8959.6 8981.1 9001.1 5940.8 6332.5 6412.3 6649.0 6650.3 7133.2 7400.6 7414.7 7420.7 7425.4 6490.3 6490.5 6665.9 6714.3 6811.6 6297.6 6435.0 6582.6 6740.8 6766.4 6173.8 6272.0 6274.3 6275.2 6279.6 4357.8 4433.0 4468.3 4546.8 4600.1 4276.9 4452.7 4495.9 4518.8 4537.0 04:28:34 INFO - PROCESS | 25364 | 04:28:34 INFO - PROCESS | 25364 | [#4] prototype.html Cycles:180 Average:4212.07 Median:4776.07 stddev:1225.22 (25.7%) stddev-sans-first:1192.95 04:28:34 INFO - PROCESS | 25364 | Values: 299.8 303.0 305.7 312.4 313.7 4911.7 4938.0 4956.8 4960.8 5001.5 4864.3 4908.7 4919.9 4920.5 4924.0 3895.7 3910.9 3913.8 3918.3 3929.9 3774.9 3816.8 3846.3 3915.6 3924.8 3795.4 3805.9 3820.4 3823.5 3824.2 3775.6 3790.8 3798.2 3803.6 3806.9 3194.7 3265.0 3276.7 3336.5 3346.6 4685.5 4689.5 4701.1 4708.9 4709.3 4331.9 4332.9 4337.6 4337.7 4341.9 4781.8 4795.4 5045.6 5065.4 5092.9 3716.0 3718.0 3720.7 3726.6 3733.4 5294.2 5308.2 5318.5 5329.3 5331.3 3695.9 3726.9 3771.9 3814.4 3820.5 3882.7 3883.8 3890.2 3893.9 3903.0 4377.6 4384.3 4388.8 4392.0 4399.6 4838.9 5147.4 5156.7 5175.5 5176.4 1261.8 1273.7 1283.7 1283.8 1290.5 804.2 825.3 836.0 840.2 841.0 4082.3 4088.3 4097.4 4105.2 4138.8 4652.0 4653.0 4664.7 4678.3 4704.8 4096.9 4101.7 4106.8 4109.1 4122.5 2497.0 2589.1 2777.5 2806.8 2809.3 4770.4 4875.4 4881.7 4893.7 4897.0 5237.2 5370.9 5411.2 5419.3 5424.9 4838.6 5018.4 5027.2 5028.3 5033.5 5261.5 5276.0 5279.9 5288.6 5296.2 5158.8 5167.4 5175.3 5179.9 5180.2 4812.8 5003.7 5007.8 5008.5 5010.8 3702.4 3721.4 3723.2 3724.5 3724.9 5197.7 5236.9 5240.2 5254.6 5281.3 4863.7 5120.4 5136.0 5143.5 5155.9 5097.6 5110.5 5122.3 5123.3 5127.8 5015.0 5022.7 5024.2 5032.7 5052.0 4902.6 5085.2 5124.9 5135.5 5139.5 5011.6 5022.8 5032.5 5039.4 5041.6 04:28:34 INFO - PROCESS | 25364 | 04:28:34 INFO - PROCESS | 25364 | [#5] yui.html Cycles:180 Average:16622.90 Median:27772.45 stddev:23460.76 (84.5%) stddev-sans-first:23495.64 04:28:34 INFO - PROCESS | 25364 | Values: 578.6 593.4 609.5 662.1 663.2 11701.5 12259.1 12554.6 12560.6 12750.7 12116.8 12432.0 12456.4 12473.4 12475.3 626.4 749.8 769.1 771.9 772.5 733.3 758.0 759.1 760.9 760.9 794.3 797.2 799.5 799.7 799.7 644.9 794.7 794.9 795.0 795.6 569.4 583.8 584.6 585.8 586.2 12287.8 12318.0 12329.6 12356.1 12358.1 11576.4 11764.2 11889.3 11959.1 12193.8 11166.4 11268.8 11291.6 11334.5 11421.1 3979.5 3996.3 4034.4 4052.6 4188.7 61852.4 61976.4 62107.4 62186.7 62207.0 9241.0 9375.4 9406.2 9497.2 9528.7 17119.1 17166.2 17268.0 17424.6 17514.7 5994.5 6100.3 6217.9 6267.3 6447.3 3555.5 3564.6 3582.2 3603.6 3609.4 2622.0 2686.5 2706.6 2741.4 2743.1 481.5 483.2 489.4 501.6 507.3 462.6 487.3 524.7 557.3 558.2 7238.0 7433.1 7544.6 7609.5 7859.8 486.4 553.5 569.8 575.3 588.4 3828.1 3909.3 3924.4 3936.6 4016.6 52271.7 52291.5 75300.0 101262.0 101543.0 78965.2 81047.0 81069.0 81305.2 82293.6 54991.5 73013.6 74174.0 75355.6 77597.0 7406.2 7455.6 7605.5 7668.2 7772.4 42789.0 44043.8 44176.8 44299.0 44542.6 57067.0 58014.0 60578.0 64445.0 65134.0 8937.2 9154.3 9347.3 9662.8 10318.1 10342.8 10363.8 10695.5 11001.6 11004.9 9512.5 11167.2 11728.0 12054.2 12717.7 10981.9 11177.9 11658.5 12072.4 12091.7 11197.8 11674.8 12195.4 12250.3 12594.1 9617.2 9713.8 9876.0 10196.2 10263.2 8848.8 8875.3 9596.3 9686.0 9789.2 04:28:34 INFO - PROCESS | 25364 | -------- Summary: end -------- 04:28:34 INFO - PROCESS | 25364 | 04:28:35 INFO - TEST-INFO | 25364: exit 0 04:28:35 INFO - TEST-OK | dromaeo_css | took 1118643ms 04:28:35 INFO - TEST-START | kraken 04:28:35 INFO - operating with platform_type : linux_ 04:28:35 INFO - Initialising browser for kraken test... 04:28:35 INFO - TEST-INFO | started process 25552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0pjibK/profile http://localhost:48761/getInfo.html) 04:28:38 INFO - PROCESS | 25552 | JavaScript error: , line 0: uncaught exception: undefined 04:28:38 INFO - PROCESS | 25552 | __metrics Screen width/height:1600/1200 04:28:38 INFO - PROCESS | 25552 | colorDepth:24 04:28:38 INFO - PROCESS | 25552 | Browser inner width/height: 1024/697 04:28:38 INFO - PROCESS | 25552 | __metrics 04:28:39 INFO - PROCESS | 25552 | 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" 04:28:39 INFO - PROCESS | 25552 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:40 INFO - TEST-INFO | 25552: exit 0 04:28:40 INFO - Browser initialized. 04:28:40 INFO - Running cycle 1/1 for kraken test... 04:28:40 INFO - TEST-INFO | started process 25629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0pjibK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:52 INFO - PROCESS | 25629 | RSS: Main: 159723520 04:28:52 INFO - PROCESS | 25629 | 04:28:55 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48761/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:56 INFO - PROCESS | 25629 | RSS: Main: 215801856 04:28:56 INFO - PROCESS | 25629 | 04:28:59 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48761/tests/kraken/driver.html?testName=audio-dft) 04:28:59 INFO - PROCESS | 25629 | RSS: Main: 194244608 04:28:59 INFO - PROCESS | 25629 | 04:29:02 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48761/tests/kraken/driver.html?testName=audio-fft) 04:29:03 INFO - PROCESS | 25629 | RSS: Main: 273666048 04:29:03 INFO - PROCESS | 25629 | 04:29:05 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48761/tests/kraken/driver.html?testName=audio-oscillator) 04:29:06 INFO - PROCESS | 25629 | RSS: Main: 182288384 04:29:06 INFO - PROCESS | 25629 | 04:29:08 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:09 INFO - PROCESS | 25629 | RSS: Main: 186814464 04:29:09 INFO - PROCESS | 25629 | 04:29:12 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48761/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:12 INFO - PROCESS | 25629 | RSS: Main: 222789632 04:29:12 INFO - PROCESS | 25629 | 04:29:16 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48761/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:17 INFO - PROCESS | 25629 | RSS: Main: 222040064 04:29:17 INFO - PROCESS | 25629 | 04:29:19 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48761/tests/kraken/driver.html?testName=json-parse-financial) 04:29:20 INFO - PROCESS | 25629 | RSS: Main: 221429760 04:29:20 INFO - PROCESS | 25629 | 04:29:22 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:22 INFO - PROCESS | 25629 | RSS: Main: 186621952 04:29:22 INFO - PROCESS | 25629 | 04:29:24 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48761/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:25 INFO - PROCESS | 25629 | RSS: Main: 193957888 04:29:25 INFO - PROCESS | 25629 | 04:29:27 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:28 INFO - PROCESS | 25629 | RSS: Main: 196456448 04:29:28 INFO - PROCESS | 25629 | 04:29:30 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:31 INFO - PROCESS | 25629 | RSS: Main: 191430656 04:29:31 INFO - PROCESS | 25629 | 04:29:34 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:35 INFO - PROCESS | 25629 | RSS: Main: 194981888 04:29:35 INFO - PROCESS | 25629 | 04:29:36 INFO - PROCESS | 25629 | Cycle 1(1): loaded http://localhost:48761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48761/tests/kraken/driver.html?testName=ai-astar) 04:29:37 INFO - PROCESS | 25629 | RSS: Main: 245186560 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | __start_tp_report 04:29:37 INFO - PROCESS | 25629 | _x_x_mozilla_page_load 04:29:37 INFO - PROCESS | 25629 | _x_x_mozilla_page_load_details 04:29:37 INFO - PROCESS | 25629 | |i|pagename|runs| 04:29:37 INFO - PROCESS | 25629 | |0;ai-astar;107;114;115;116;115;116;114;114;113;114 04:29:37 INFO - PROCESS | 25629 | |1;audio-beat-detection;156;126;125;198;121;125;149;127;159;124 04:29:37 INFO - PROCESS | 25629 | |2;audio-dft;161;162;161;162;162;163;161;169;162;161 04:29:37 INFO - PROCESS | 25629 | |3;audio-fft;76;75;77;114;76;78;75;75;112;76 04:29:37 INFO - PROCESS | 25629 | |4;audio-oscillator;86;85;122;86;85;86;116;86;85;133 04:29:37 INFO - PROCESS | 25629 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;117 04:29:37 INFO - PROCESS | 25629 | |6;imaging-darkroom;146;146;146;147;146;147;147;146;145;146 04:29:37 INFO - PROCESS | 25629 | |7;imaging-desaturate;94;96;95;94;95;95;95;95;95;95 04:29:37 INFO - PROCESS | 25629 | |8;json-parse-financial;61;60;61;59;61;61;62;60;61;59 04:29:37 INFO - PROCESS | 25629 | |9;json-stringify-tinderbox;65;68;66;66;67;66;66;74;65;67 04:29:37 INFO - PROCESS | 25629 | |10;stanford-crypto-aes;80;79;79;85;79;79;79;81;80;78 04:29:37 INFO - PROCESS | 25629 | |11;stanford-crypto-ccm;131;128;128;127;129;127;128;127;167;129 04:29:37 INFO - PROCESS | 25629 | |12;stanford-crypto-pbkdf2;167;166;163;169;165;170;173;167;166;165 04:29:37 INFO - PROCESS | 25629 | |13;stanford-crypto-sha256-iterative;67;67;66;67;68;68;67;66;66;69 04:29:37 INFO - PROCESS | 25629 | __end_tp_report 04:29:37 INFO - PROCESS | 25629 | __start_cc_report 04:29:37 INFO - PROCESS | 25629 | _x_x_mozilla_cycle_collect,1944 04:29:37 INFO - PROCESS | 25629 | __end_cc_report 04:29:37 INFO - PROCESS | 25629 | __startTimestamp1469791777027__endTimestamp 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | ------- Summary: start ------- 04:29:37 INFO - PROCESS | 25629 | Number of tests: 14 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.50 stddev:2.57 (2.2%) stddev-sans-first:1.01 04:29:37 INFO - PROCESS | 25629 | Values: 107.0 114.0 115.0 116.0 115.0 116.0 114.0 114.0 113.0 114.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:138.00 stddev:24.68 (17.9%) stddev-sans-first:25.58 04:29:37 INFO - PROCESS | 25629 | Values: 156.0 126.0 125.0 198.0 121.0 125.0 149.0 127.0 159.0 124.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:2.41 (1.5%) stddev-sans-first:2.51 04:29:37 INFO - PROCESS | 25629 | Values: 161.0 162.0 161.0 162.0 162.0 163.0 161.0 169.0 162.0 161.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:15.64 (20.6%) stddev-sans-first:16.35 04:29:37 INFO - PROCESS | 25629 | Values: 76.0 75.0 77.0 114.0 76.0 78.0 75.0 75.0 112.0 76.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:85.50 stddev:18.85 (22.0%) stddev-sans-first:19.57 04:29:37 INFO - PROCESS | 25629 | Values: 86.0 85.0 122.0 86.0 85.0 86.0 116.0 86.0 85.0 133.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:29:37 INFO - PROCESS | 25629 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:29:37 INFO - PROCESS | 25629 | Values: 146.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 145.0 146.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 04:29:37 INFO - PROCESS | 25629 | Values: 94.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:61.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 04:29:37 INFO - PROCESS | 25629 | Values: 61.0 60.0 61.0 59.0 61.0 61.0 62.0 60.0 61.0 59.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:66.50 stddev:2.62 (3.9%) stddev-sans-first:2.68 04:29:37 INFO - PROCESS | 25629 | Values: 65.0 68.0 66.0 66.0 67.0 66.0 66.0 74.0 65.0 67.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:1.97 (2.5%) stddev-sans-first:2.09 04:29:37 INFO - PROCESS | 25629 | Values: 80.0 79.0 79.0 85.0 79.0 79.0 79.0 81.0 80.0 78.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:128.50 stddev:12.32 (9.6%) stddev-sans-first:13.07 04:29:37 INFO - PROCESS | 25629 | Values: 131.0 128.0 128.0 127.0 129.0 127.0 128.0 127.0 167.0 129.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.00 stddev:2.88 (1.7%) stddev-sans-first:3.06 04:29:37 INFO - PROCESS | 25629 | Values: 167.0 166.0 163.0 169.0 165.0 170.0 173.0 167.0 166.0 165.0 04:29:37 INFO - PROCESS | 25629 | 04:29:37 INFO - PROCESS | 25629 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 04:29:37 INFO - PROCESS | 25629 | Values: 67.0 67.0 66.0 67.0 68.0 68.0 67.0 66.0 66.0 69.0 04:29:37 INFO - PROCESS | 25629 | -------- Summary: end -------- 04:29:37 INFO - PROCESS | 25629 | 04:29:38 INFO - TEST-INFO | 25629: exit 0 04:29:38 INFO - TEST-OK | kraken | took 63024ms 04:29:38 INFO - SUITE-END | took 1181s 04:29:38 INFO - Completed test suite (00:19:41) 04:29:38 INFO - javascript benchmark 04:29:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.234621959632, 2639.458910923261, 2670.2389818901606, 2674.157640343291, 2677.5314319993995, 4592.402987611614, 4651.651126165534, 4723.480417154115, 4842.128416884963, 4846.539578740018, 4702.835400760974, 4738.810447582093, 4750.121227572901, 4768.52314768523, 4827.468978412372, 4322.092360604277, 4354.042110735633, 4368.49762277339, 4400.911981760363, 4521.932171017437, 4421.182081314951, 4464.910701785962, 4478.417805685256, 4495.685302028859, 4496.752678602676, 4259.041715613993, 4382.189294980407, 4383.868483945486, 4441.844535441261, 4466.731996080245, 4305.354196870463, 4313.0, 4327.221100201962, 4360.49854266757, 4386.517483076859, 4303.07483890965, 4314.050908800059, 4360.978195109036, 4373.190959672471, 4407.008423104808, 4694.976525117387, 4764.785584648699, 4812.759362031919, 4818.180909245437, 4822.565969062766, 4874.829380971684, 5022.372203474566, 5046.318746969149, 5065.366829146356, 5150.716710580917, 5094.363204599425, 5107.3360463139925, 5148.5623721983675, 5151.6908985461, 5159.638825282232, 4808.471068182497, 4810.518948105197, 4812.037592481448, 4814.614830813526, 4814.831480898151, 5035.521625445577, 5131.897362052738, 5155.74221288934, 5192.844214673566, 5232.084385232569, 4996.125678006334, 5036.0, 5047.4447810740785, 5047.9495205048215, 5051.191809310492, 5078.111330517218, 5081.339425874613, 5085.542301192911, 5135.35808023997, 5143.305653736773, 4820.590249828804, 4837.9032419351415, 4915.992221594564, 4918.163912134945, 4981.576565991859, 4888.6577939543895, 4904.166291730415, 4908.656394052454, 4940.011997600423, 4957.281194226817, 4198.223328684203, 4202.663786897041, 4205.558416366299, 4238.766867822238, 4247.384129301234, 3667.4865518827387, 3668.3396988541786, 3673.522442082512, 3719.5536535615897, 3723.069232691827, 4375.059362237071, 4422.469303683514, 4422.867313980586, 4452.398926144993, 4491.842785502492, 5132.0, 5137.255098010843, 5138.820141295037, 5141.126008578551, 5195.48045195485, 4235.216484950232, 4399.450068741407, 4444.066745983315, 4449.421575195204, 4490.640748740093, 4525.162844873709, 4537.977310113494, 4549.226631472658, 4570.840020599329, 4612.30815377696, 4821.855344339676, 4830.7101573905675, 4831.685940413932, 4831.73425461603, 4873.926891096708, 4937.5556199942175, 5073.416557095834, 5087.3132127163835, 5105.566026887607, 5146.073706732824, 4751.334813126096, 4774.809007639795, 4785.449673287617, 4788.353572267699, 4853.0, 4992.975035124801, 4997.675151115166, 5006.249062640633, 5010.348654674869, 5059.46875578059, 4886.975565122151, 5061.898762024813, 5074.822381216787, 5075.695458272516, 5127.615428842777, 4867.123917694849, 4895.632827537877, 4902.681325713817, 4930.211166213532, 4952.207646776643, 4941.728204948762, 4953.083679519156, 4954.380702412199, 4956.752162391938, 5002.699838009731, 4730.1958667026, 4863.221884498464, 4864.0, 4917.213245880642, 4921.8523444296725, 4931.284963680175, 4931.753412329441, 4979.800807967641, 4993.875153121201, 5010.972750586194, 4872.634552408513, 4878.707277563358, 4885.926711099265, 4894.216925291937, 4937.23472861707], "value": 4658.413785194842, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.9829905102847, 577.5264283287703, 589.9764009439623, 596.7791916990711, 601.7773423833177, 26653.73346266539, 38286.42570361443, 39380.409293860546, 39579.604203957984, 44105.55894441055, 40104.39843402351, 40617.0, 40647.0, 40665.0, 40717.38923916136, 7578.090629124499, 7708.11356693979, 7713.652885620132, 7728.459007869451, 7796.688132474695, 7559.773206803778, 7612.657430415645, 7614.352780013678, 7637.656305466239, 7647.044119485065, 7658.425618078639, 7678.846423071535, 7694.884576731325, 7701.191374905638, 7702.499337543042, 7591.620418979029, 7635.6563954621615, 7646.770596882075, 7684.615769211573, 7697.2302769722855, 7750.069991600988, 7821.687132514692, 7822.061352637663, 7824.530528168328, 7827.178146294671, 37590.0, 38082.42876356857, 38117.0, 38206.80896595527, 38640.42039369412, 3000.4749168895573, 3008.1877892968996, 3095.2880837407297, 3100.860461279225, 3264.265540253424, 28144.718552814415, 28204.294892627644, 28209.294767630974, 28563.285917852012, 29337.85331073331, 3073.569700241968, 3109.5024796032526, 3115.9376812463624, 3146.921326966821, 3217.1635374802486, 183716.08141959205, 184189.0, 184571.07714461343, 185213.0739346308, 185502.0, 53069.469305306455, 53337.73331133319, 53413.06228157411, 53441.198382024304, 53463.46536534662, 32497.0, 33196.50205246923, 33254.83372583122, 35511.644883550834, 35517.0, 15619.921900390425, 15814.0, 15821.841781582038, 15824.604384890239, 15833.841661583238, 11892.524299027942, 11955.64133076009, 11958.40207989597, 11968.880311196777, 11973.46119424628, 18050.1877415514, 18127.72808407875, 18131.274749010157, 18295.359662411753, 18326.083695815156, 6655.534112612071, 6808.795736127924, 6947.0, 6949.131358580177, 6972.574208468067, 790.3124281874691, 855.8416692911832, 864.4726716702806, 866.3242670716851, 888.2183678362999, 27593.310167245578, 27687.584686229722, 27993.160205193875, 28201.028951077576, 28422.573661395094, 775.4223103787714, 962.3936919740659, 989.1938070472542, 1016.8373060310315, 1029.2229366827996, 14798.92600537012, 15096.773548396563, 15109.093454392772, 15243.923780381027, 15280.617984550476, 184231.0, 613397.0, 624219.0, 628467.8649101335, 630832.0, 48740.51259487431, 49375.25937110946, 49422.50577494179, 49422.752886236056, 49422.752886236056, 1072.367303291062, 1103.448275862069, 1179.3042105157826, 1203.8555373355252, 1204.3797444316185, 26072.478550429263, 28867.885148633402, 29005.0, 31542.842285789342, 31624.209394765316, 46581.0, 47348.52651473441, 47357.289640656105, 47376.0, 47422.525774741815, 341438.0, 342717.0, 343498.0, 344693.0, 347886.0, 24366.75633243716, 24749.133780317603, 26487.735122648526, 27039.594406084318, 27461.86269068722, 41262.1747565053, 41527.792361038, 41537.1692566153, 41557.37663935104, 41740.58259417367, 34712.652873471954, 35065.64934350624, 35161.47257791084, 35437.645623544464, 35448.82275588605, 35394.46908296429, 35511.644883550834, 35811.64188358083, 35948.10129746777, 36068.4589731149, 35081.0, 35131.0, 35727.82136089407, 35874.64125358713, 35958.0, 30602.84698576493, 32585.34829303448, 32744.0, 32806.0, 32811.83594082014, 24415.145469908468, 24499.142530011362, 24819.503609928062, 25148.62277065882, 25257.242282731546], "value": 17324.106286023107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.51414420801416, 348.7889826654872, 349.21601005742104, 357.51735157537314, 358.3853690920072, 12832.294223817686, 16114.35542578297, 16548.66902661946, 17170.39903603374, 17953.64092718145, 17302.56743581408, 17302.913485432586, 17331.653366932685, 17656.646867062653, 17800.910995445036, 4916.827911023097, 4928.630352723551, 5030.773615187307, 5062.696238225718, 5075.6447048706605, 3779.130799916007, 4891.290762839386, 4972.950270497285, 5684.602077854552, 5984.970075149618, 5878.5297176225795, 5899.174115623795, 5903.291605007405, 5911.231539899807, 5912.852178695545, 5060.493950604947, 5284.81503147388, 5321.866953326159, 5408.432114627947, 5901.203337549418, 5229.529342359206, 5246.895062098775, 5260.684358938438, 5269.947300527022, 5270.446603106657, 12281.201721888137, 12398.380080995914, 12521.311327876963, 12584.182028168232, 12646.873531264662, 1758.4900378890106, 1808.6021075363399, 1863.236073209991, 2011.1151093518804, 2163.350994701599, 8787.25308348791, 8949.105089491064, 8994.145556172152, 9445.197158241557, 9641.132298093135, 1721.9655606887918, 1725.930962761488, 1728.5937804615905, 1792.6773180827445, 1818.163644723429, 69379.71512991164, 71473.64263178704, 72931.0, 74131.0, 76327.23672763257, 9857.211423086279, 9935.503224838729, 9936.80126397468, 10172.237082218864, 10605.628802991858, 13481.056326057278, 13482.730345393038, 13519.459221631221, 13521.729565408834, 13522.25627590492, 7403.8149046274275, 7542.962285188539, 7627.122880868771, 7727.1886451922865, 7818.960905195438, 7305.707771689073, 7380.630968451556, 7410.814729631802, 7602.50583712057, 7611.923880761232, 4275.508316543575, 4327.6970612057485, 4329.523752387235, 4329.675274354436, 4451.888702782391, 1706.3601149568913, 1783.2599471219557, 1797.3475747202183, 1801.7567628370264, 1839.41138835574, 378.50982977044794, 387.413069200162, 391.98236079376494, 406.5710675237594, 758.2417582417582, 10623.256372054037, 10631.308964917256, 10957.561697532168, 11056.723581910355, 11267.830982535268, 388.86645428575383, 408.82829211731143, 415.91265834175164, 427.1478400590779, 439.1042273761491, 5665.716714164275, 5721.284839395075, 5835.0, 5842.152887831326, 6028.065649824284, 361100.0, 399282.0, 408437.0, 409658.0, 409908.0, 82390.43983933236, 82607.5869620648, 83065.0, 84195.0, 87793.0, 436.7030419314833, 438.7586827245066, 439.45068664169787, 440.70913197289633, 444.3579028304134, 10014.449205293779, 10078.798424031625, 10113.848292275768, 10216.438095904796, 10459.68620941373, 34453.0, 37437.4384384229, 38583.0, 39190.60809391984, 39539.604603954744, 43939.78030109829, 51331.74334128306, 51590.226146608584, 51661.48338516717, 53186.0, 7655.0, 7758.185390534139, 7790.259925307087, 7947.960260198662, 8144.714934977247, 11283.0, 12168.634940951786, 12203.938980305042, 12269.509219631114, 12620.116591838483, 10360.222983276435, 10366.326188797704, 10552.525136369035, 10850.511726972147, 11117.555297788322, 5154.304168937146, 7483.476156668981, 10674.452204430469, 10693.09108725767, 10800.189985750943, 10050.09549140581, 10446.216533759847, 10557.472126393803, 10696.0, 10698.358098514114, 7691.461597688108, 7719.575423351769, 7821.374290056896, 7979.441439099207, 8045.316148127475, 8874.378793484653, 10196.3372380795, 10371.0, 10441.373517588665, 10835.67492975212], "value": 7392.417462871266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.3387303919362, 1319.4985905355963, 1378.8552202018789, 1408.9788653170203, 1678.0602862397059, 6437.259715132755, 7334.779956601304, 7548.849023019543, 7607.7717668469895, 7882.054153501574, 7711.267429594193, 7761.767146985585, 7770.4172187085915, 7780.92219077809, 7786.182450842665, 2165.1123039553827, 2189.8029177374033, 2190.211523851412, 2190.9233176838816, 2191.6274233380364, 2099.2337796704246, 2122.5330427305967, 2217.556488702258, 2221.1670623516184, 2222.1666874921902, 2167.6856855755905, 2179.7057397251406, 2185.7158569385956, 2189.901454434554, 2216.6674998750154, 2156.3962090614655, 2158.0504577985635, 2159.2334721173916, 2160.2331172433796, 2161.0, 2104.0847231454213, 2145.8819764912923, 2147.5168087180414, 2159.66525188596, 2167.5989941860807, 7727.420443466706, 7769.339606133485, 7819.0617125945255, 7829.64766585505, 7831.490953088031, 4524.479684836253, 4671.672982891199, 4701.365315682373, 4788.4253889533475, 4789.137955168068, 2860.3850172213074, 2965.8368789716556, 2983.209449495885, 2993.6108305920093, 3012.683668214828, 877.9736607901773, 888.706726780161, 894.4633220067972, 896.8475359188953, 914.9130832570895, 10256.94871525645, 10259.17926565873, 10304.124149447305, 10358.53386597605, 10376.273660843744, 3779.905502362463, 4016.477857878457, 4077.7145599807727, 4090.5295890972325, 4112.157007813451, 8330.791730206793, 8338.374621903382, 8346.582670866554, 8346.791330216793, 8356.791080223044, 4621.768911554409, 4621.861344159681, 4623.606993405599, 4625.699329543569, 4636.698614590041, 3668.1563240454843, 3743.1016556026357, 4190.958090419057, 4277.294246449301, 4301.032267739796, 3306.123877172503, 3316.6185888622636, 3398.8300584970652, 3466.1681196512654, 3490.214701692099, 997.187292356727, 1030.1501261459325, 1035.2028937717914, 1044.7127040063892, 1053.694428615693, 678.8235058884726, 800.8518424091561, 809.1059379385812, 815.1807433529265, 821.4578378270313, 5071.46749591295, 5106.821261255838, 5169.948300517022, 5212.348456442945, 5402.243685883979, 840.4537050916953, 866.4844417571535, 870.1646419437285, 889.9110088991179, 915.3318077803108, 3413.197898493852, 3613.0, 3618.782873027627, 3633.5821380541047, 3796.7532110413285, 9339.486328252011, 9560.378575392577, 9680.951595241979, 9696.224302055818, 9715.417074975525, 9619.0, 9624.951875240578, 9645.614175432904, 9651.276154288456, 9665.371750836313, 7180.605066721276, 7222.09723784527, 7278.163011253668, 7397.112346518452, 7405.8889116663295, 4955.5044495550155, 5055.823046193365, 5069.518395752398, 5175.508326708957, 5196.584273258206, 8691.261242794433, 8754.124587541195, 8817.382783205114, 8826.867596985921, 8935.061818508962, 8467.57662116904, 8922.420042697204, 8959.641614335354, 8981.101889810967, 9001.144891235323, 5940.762369505172, 6332.493400528039, 6412.326705695835, 6648.966755166193, 6650.268470468342, 7133.2153463117975, 7400.555966642019, 7414.666340014604, 7420.740274090381, 7425.368843648134, 6490.286068532552, 6490.513211509061, 6665.866682666417, 6714.328567143247, 6811.557248778813, 6297.590656607306, 6435.03474478832, 6582.637954912334, 6740.797776066725, 6766.424853887278, 6173.783917562864, 6272.0, 6274.341194174546, 6275.152854364603, 6279.623222606659, 4357.847475338348, 4432.955670443254, 4468.262736648417, 4546.795394207203, 4600.07998400328, 4276.87169384919, 4452.710573812692, 4495.887602809825, 4518.774061296987, 4536.954630453653], "value": 4052.1773797234405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8365890589629, 302.9833359165245, 305.6897249291968, 312.4251377465463, 313.67377926955965, 4911.680740751849, 4938.0, 4956.826511072113, 4960.776765045577, 5001.499550134963, 4864.294677271793, 4908.705477671342, 4919.877003074916, 4920.458749537548, 4923.975380123104, 3895.7272990890647, 3910.9413358799643, 3913.8043097845134, 3918.2751191029606, 3929.9410508842248, 3774.867539738081, 3816.7709937403843, 3846.326892793764, 3915.6084391560903, 3924.8037598120122, 3795.4496597993275, 3805.923881522368, 3820.36963900956, 3823.541175058997, 3824.1778017726183, 3775.6413140751583, 3790.7915064671433, 3798.240351929625, 3803.6006219347123, 3806.8667596634123, 3194.7284480819158, 3264.9673503264903, 3276.705096541299, 3336.51620515024, 3346.598408191033, 4685.508021657711, 4689.50760170184, 4701.130290896161, 4708.882277943045, 4709.317149013374, 4331.935020974656, 4332.913341733148, 4337.587929146726, 4337.674674399401, 4341.934870976938, 4781.784819683123, 4795.376601041877, 5045.612456574471, 5065.4174769901565, 5092.872678183038, 3716.0, 3717.962820371789, 3720.7303544837628, 3726.571444283915, 3733.4213196954242, 5294.205869119624, 5308.230306605559, 5318.521333080042, 5329.25390445338, 5331.333583302087, 3695.9076023099637, 3726.9440958385103, 3771.8868433947027, 3814.389697648363, 3820.503334566489, 3882.7282090253975, 3883.8446462141765, 3890.1636148228267, 3893.9415908761393, 3902.9804850975565, 4377.584129507692, 4384.298512238027, 4388.780560971939, 4391.956080439155, 4399.582039706287, 4838.927416088762, 5147.378575748628, 5156.716380599028, 5175.482451754794, 5176.378834539804, 1261.8359613250402, 1273.745360819592, 1283.6854970532092, 1283.8459384873875, 1290.451558087809, 804.1596531624466, 825.3108654273749, 835.9968038354, 840.2269911681268, 840.9957950210332, 4082.2856000199845, 4088.264112459726, 4097.385392191195, 4105.2405305018665, 4138.772367519755, 4652.0, 4652.953470465252, 4664.667666166916, 4678.298255261738, 4704.764761761899, 4096.938545921814, 4101.712880098424, 4106.815193316308, 4109.137081212919, 4122.484689413824, 2496.9649735465537, 2589.0970136949327, 2777.527820270559, 2806.789490788199, 2809.283632673696, 4770.356001939694, 4875.43932447773, 4881.707097574157, 4893.681910675795, 4897.0, 5237.16205407133, 5370.892582148414, 5411.242426060355, 5419.34967803866, 5424.918626220609, 4838.637102217277, 5018.372703412074, 5027.245913113063, 5028.296038554606, 5033.496650335011, 5261.500157485033, 5276.023935571931, 5279.8680032997945, 5288.603354748332, 5296.179092240709, 5158.793648254028, 5167.405748338839, 5175.301334319969, 5179.948200517946, 5180.197069454241, 4812.807487700453, 5003.724795136157, 5007.774650140679, 5008.499150085108, 5010.824621138243, 3702.407614781622, 3721.423179407196, 3723.218124193841, 3724.459953306701, 3724.851005959731, 5197.7141257229705, 5236.89526209466, 5240.161574148118, 5254.5533629641905, 5281.260623512634, 4863.659543832039, 5120.436751957207, 5135.998480296306, 5143.537081662668, 5155.896882062413, 5097.592192624507, 5110.514501122388, 5122.308488354024, 5123.282740416419, 5127.820526281712, 5015.022070696179, 5022.673526220784, 5024.196128619404, 5032.7483625819295, 5051.974740126276, 4902.583280421061, 5085.160948443466, 5124.871878203075, 5135.5078546588675, 5139.460356662496, 5011.624128190328, 5022.799088036438, 5032.521910418504, 5039.370078740158, 5041.621878359211], "value": 3821.4404366185336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.6499168003355, 593.3859901069092, 609.5002098279413, 662.0863208771895, 663.2273401487267, 11701.473433695483, 12259.08056895734, 12554.623361299164, 12560.560380386689, 12750.744985100293, 12116.757664846698, 12432.0, 12456.439460224288, 12473.37633118345, 12475.251484910888, 626.3548544998636, 749.8050506868212, 769.0847891009709, 771.9382449404034, 772.5133166105373, 733.3216774483608, 757.9696812127509, 759.0587671287591, 760.8706519891632, 760.9315161635452, 794.2613369566301, 797.1510341486328, 799.5083023940293, 799.6961154761183, 799.7001124578284, 644.8871447496716, 794.7099308752322, 794.940379471539, 794.9761507154794, 795.6459375577899, 569.4476357932798, 583.76941108262, 584.6170758153417, 585.8154681275385, 586.2203269651353, 12287.815682764765, 12318.0, 12329.630111096682, 12356.073294502858, 12358.134930554776, 11576.363300018496, 11764.176507644468, 11889.28664280146, 11959.103067269902, 12193.817092743617, 11166.441677916153, 11268.774624507547, 11291.604793832259, 11334.489947952361, 11421.086313094933, 3979.507322710069, 3996.320625493644, 4034.3545032794614, 4052.5947405259535, 4188.748675079505, 61852.38147618511, 61976.38023619751, 62107.378926211066, 62186.68906655483, 62207.0, 9241.0, 9375.437473751597, 9406.200472959876, 9497.240220782322, 9528.666496672584, 17119.14404279781, 17166.22751976164, 17268.0, 17424.5643858902, 17514.737278940825, 5994.460498555151, 6100.328963813977, 6217.875642487215, 6267.2792628847355, 6447.2907980122145, 3555.5022296878456, 3564.6435356464144, 3582.1940063486027, 3603.621619729943, 3609.4224924012033, 2621.9606705899428, 2686.529857274969, 2706.580480025599, 2741.4105967217142, 2743.1222008957343, 481.4944308476086, 483.2461360277978, 489.3662706794709, 501.633807320658, 507.31259143860274, 462.6275847942439, 487.2642310111757, 524.7061645478544, 557.275541795664, 558.1934105217921, 7238.0, 7433.10802703679, 7544.6227688616445, 7609.505382150142, 7859.84280314402, 486.35315031008673, 553.4520824383831, 569.7720911635379, 575.3412342867477, 588.4145275450953, 3828.1386687994977, 3909.276783795007, 3924.430957511202, 3936.566977632458, 4016.55817860041, 52271.73864130655, 52291.47708522866, 75300.0, 101262.0, 101543.0, 78965.21034789579, 81047.0, 81069.0, 81305.18694813094, 82293.58853205695, 54991.45008549863, 73013.63493182606, 74174.03303867785, 75355.62322188464, 77597.0, 7406.18531961473, 7455.552666840007, 7605.46761726696, 7668.240908506006, 7772.417068719982, 42789.0, 44043.779781100886, 44176.77911610421, 44299.0, 44542.55457445384, 57067.0, 58014.0, 60578.0, 64445.0, 65134.0, 8937.150970658036, 9154.26765858743, 9347.252219822534, 9662.806743865223, 10318.071373576415, 10342.844857327296, 10363.792724145625, 10695.5187016586, 11001.61494347694, 11004.889951100387, 9512.476813775032, 11167.218294719292, 11728.0, 12054.156209065632, 12717.745645087232, 10981.890181098406, 11177.88822111801, 11658.53365865356, 12072.396380181131, 12091.697707557381, 11197.776044478902, 11674.76650467003, 12195.390230488618, 12250.264984100982, 12594.118411711092, 9617.2306215504, 9713.757156071155, 9876.0, 10196.235282354002, 10263.178945684476, 8848.778780530538, 8875.33434992391, 9596.280278978966, 9685.951570242103, 9789.167920726533], "value": 6244.369382895494, "unit": "score"}], "name": "dromaeo_css", "value": 6216.147160260836, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 115.0, 116.0, 115.0, 116.0, 114.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 125.0, 198.0, 121.0, 125.0, 149.0, 127.0, 159.0, 124.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 163.0, 161.0, 169.0, 162.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 114.0, 76.0, 78.0, 75.0, 75.0, 112.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 122.0, 86.0, 85.0, 86.0, 116.0, 86.0, 85.0, 133.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 59.0, 61.0, 61.0, 62.0, 60.0, 61.0, 59.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 66.0, 67.0, 66.0, 66.0, 74.0, 65.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 85.0, 79.0, 79.0, 79.0, 81.0, 80.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 128.0, 127.0, 129.0, 127.0, 128.0, 127.0, 167.0, 129.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 163.0, 169.0, 165.0, 170.0, 173.0, 167.0, 166.0, 165.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 68.0, 68.0, 67.0, 66.0, 66.0, 69.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1529.1999999999998, "alertThreshold": 2.0}]} 04:29:38 INFO - Return code: 0 04:29:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:29:38 INFO - # TBPL SUCCESS # 04:29:38 INFO - Running post-action listener: _resource_record_post_action 04:29:38 INFO - [mozharness: 2016-07-29 11:29:38.327150Z] Finished run-tests step (success) 04:29:38 INFO - Running post-run listener: _resource_record_post_run 04:29:38 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536154112; Read time: 144; Write time: 415600 04:29:38 INFO - TinderboxPrint: CPU usage
13.0% 04:29:38 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 144 04:29:38 INFO - TinderboxPrint: I/O write bytes / time
536,154,112 / 415,600 04:29:38 INFO - TinderboxPrint: CPU idle
8,318.1 (87.0%) 04:29:38 INFO - TinderboxPrint: CPU user
1,200.0 (12.5%) 04:29:38 INFO - TinderboxPrint: Swap in / out
0 / 0 04:29:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 247066624; Read time: 120; Write time: 242608 04:29:38 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289087488; Read time: 24; Write time: 172992 04:29:38 INFO - Running post-run listener: _upload_blobber_files 04:29:38 INFO - Blob upload gear active. 04:29:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:38 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 04:29:38 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:29:38 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:29:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:29:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:48 INFO - (blobuploader) - INFO - Done attempting. 04:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:49 INFO - (blobuploader) - INFO - Done attempting. 04:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:50 INFO - (blobuploader) - INFO - Done attempting. 04:29:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:50 INFO - Return code: 0 04:29:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:29:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/caaa7435a1b3bb42f5166fae1da5b9d752e3d557c25cf1217fc12c6a24ebfbec23942ded80ec90d8b357566899c71831181905094995822ac2b15ba7e70825ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/717a3d70004f6353a6bc4bc0bdee294719e631dd25af493d64a4dfb75c054245e6335d7d051e946d8423ebc49122a5ded5bdd7b2cc97abd1cbab0e13773028b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/425288cbdc7f135c378372b89a69d25b82695811b71386878258a3dd19ac4645506edb3a0c629e677c4a0df831dbf000f51271679c4b5e7261645f9962f5a0bb"} 04:29:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:29:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:29:50 INFO - Contents: 04:29:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/caaa7435a1b3bb42f5166fae1da5b9d752e3d557c25cf1217fc12c6a24ebfbec23942ded80ec90d8b357566899c71831181905094995822ac2b15ba7e70825ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/717a3d70004f6353a6bc4bc0bdee294719e631dd25af493d64a4dfb75c054245e6335d7d051e946d8423ebc49122a5ded5bdd7b2cc97abd1cbab0e13773028b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/425288cbdc7f135c378372b89a69d25b82695811b71386878258a3dd19ac4645506edb3a0c629e677c4a0df831dbf000f51271679c4b5e7261645f9962f5a0bb"} 04:29:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:50 INFO - Copying logs to upload dir... 04:29:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:29:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.396723 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-29 04:29:49.458146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 04:29:49.461775) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/caaa7435a1b3bb42f5166fae1da5b9d752e3d557c25cf1217fc12c6a24ebfbec23942ded80ec90d8b357566899c71831181905094995822ac2b15ba7e70825ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/717a3d70004f6353a6bc4bc0bdee294719e631dd25af493d64a4dfb75c054245e6335d7d051e946d8423ebc49122a5ded5bdd7b2cc97abd1cbab0e13773028b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/425288cbdc7f135c378372b89a69d25b82695811b71386878258a3dd19ac4645506edb3a0c629e677c4a0df831dbf000f51271679c4b5e7261645f9962f5a0bb"} build_url:https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/BTvWdpBFRnaR6NGq_YL2Aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/caaa7435a1b3bb42f5166fae1da5b9d752e3d557c25cf1217fc12c6a24ebfbec23942ded80ec90d8b357566899c71831181905094995822ac2b15ba7e70825ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/717a3d70004f6353a6bc4bc0bdee294719e631dd25af493d64a4dfb75c054245e6335d7d051e946d8423ebc49122a5ded5bdd7b2cc97abd1cbab0e13773028b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/425288cbdc7f135c378372b89a69d25b82695811b71386878258a3dd19ac4645506edb3a0c629e677c4a0df831dbf000f51271679c4b5e7261645f9962f5a0bb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 04:29:49.486304) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:29:49.486605) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469790328.628768-1122587406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:29:49.572033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 04:29:49.572344) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 04:29:49.572643) ========= ========= Total master_lag: 0.19 =========