builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1462799319.66 results: success (0) buildid: 20160506162552 builduid: b72a63e889694b7881d89602fbd1d472 revision: 025d85d8686491f7975b9d2e86b97180e3f9e0fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:39.656052) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:39.656457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:39.656748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:39.673296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:39.673574) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 06:08:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 223M=0s 2016-05-09 06:08:40 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080185 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:39.766811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:39.767099) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018025 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:39.816351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:08:39.816690) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 025d85d8686491f7975b9d2e86b97180e3f9e0fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 025d85d8686491f7975b9d2e86b97180e3f9e0fa --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=337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:08:40,851 truncating revision to first 12 chars 2016-05-09 06:08:40,851 Setting DEBUG logging. 2016-05-09 06:08:40,851 attempt 1/10 2016-05-09 06:08:40,851 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/025d85d86864?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 06:08:41,940 unpacking tar archive at: mozilla-beta-025d85d86864/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:08:41.211657) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:41.211962) ========= script_repo_revision: 025d85d8686491f7975b9d2e86b97180e3f9e0fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:41.212348) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:41.212629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:08:41.222288) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-05-09 06:08:41.222575) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:08:42 INFO - MultiFileLogger online at 20160509 06:08:42 in /builds/slave/test 06:08:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:08:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:08:42 INFO - {'append_to_log': False, 06:08:42 INFO - 'base_work_dir': '/builds/slave/test', 06:08:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:08:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:08:42 INFO - 'branch': 'Mozilla-Beta', 06:08:42 INFO - 'buildbot_json_path': 'buildprops.json', 06:08:42 INFO - 'config_files': ('talos/linux_config.py',), 06:08:42 INFO - 'default_actions': ('clobber', 06:08:42 INFO - 'read-buildbot-config', 06:08:42 INFO - 'download-and-extract', 06:08:42 INFO - 'populate-webroot', 06:08:42 INFO - 'create-virtualenv', 06:08:42 INFO - 'install', 06:08:42 INFO - 'run-tests'), 06:08:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:08:42 INFO - 'download_minidump_stackwalk': True, 06:08:42 INFO - 'download_symbols': 'ondemand', 06:08:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:08:42 INFO - 'tooltool.py': '/tools/tooltool.py', 06:08:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:08:42 INFO - '/tools/misc-python/virtualenv.py')}, 06:08:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:08:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:08:42 INFO - 'installer_path': 'installer.exe', 06:08:42 INFO - 'log_level': 'info', 06:08:42 INFO - 'log_name': 'talos', 06:08:42 INFO - 'log_to_console': True, 06:08:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:08:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:08:42 INFO - 'opt_config_files': (), 06:08:42 INFO - 'pip_index': False, 06:08:42 INFO - 'sps_profile': False, 06:08:42 INFO - 'sps_profile_interval': 0, 06:08:42 INFO - 'suite': 'dromaeojs', 06:08:42 INFO - 'system_bits': '32', 06:08:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:08:42 INFO - 'title': 'talos-linux64-ix-060', 06:08:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:08:42 INFO - 'use_talos_json': True, 06:08:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:08:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:08:42 INFO - 'work_dir': 'build'} 06:08:42 INFO - ##### 06:08:42 INFO - ##### Running clobber step. 06:08:42 INFO - ##### 06:08:42 INFO - Running pre-action listener: _resource_record_pre_action 06:08:42 INFO - Running main action method: clobber 06:08:42 INFO - rmtree: /builds/slave/test/build 06:08:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:08:42 INFO - Running post-action listener: _resource_record_post_action 06:08:42 INFO - ##### 06:08:42 INFO - ##### Running read-buildbot-config step. 06:08:42 INFO - ##### 06:08:42 INFO - Running pre-action listener: _resource_record_pre_action 06:08:42 INFO - Running main action method: read_buildbot_config 06:08:42 INFO - Using buildbot properties: 06:08:42 INFO - { 06:08:42 INFO - "project": "", 06:08:42 INFO - "product": "firefox", 06:08:42 INFO - "script_repo_revision": "production", 06:08:42 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:08:42 INFO - "repository": "", 06:08:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:08:42 INFO - "buildid": "20160506162552", 06:08:42 INFO - "pgo_build": "True", 06:08:42 INFO - "basedir": "/builds/slave/test", 06:08:42 INFO - "buildnumber": 9, 06:08:42 INFO - "slavename": "talos-linux64-ix-060", 06:08:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:08:42 INFO - "platform": "ubuntu64_hw", 06:08:42 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:08:42 INFO - "branch": "mozilla-beta", 06:08:42 INFO - "repo_path": "releases/mozilla-beta", 06:08:42 INFO - "revision": "025d85d8686491f7975b9d2e86b97180e3f9e0fa", 06:08:42 INFO - "stage_platform": "linux64-pgo", 06:08:42 INFO - "builduid": "b72a63e889694b7881d89602fbd1d472", 06:08:42 INFO - "slavebuilddir": "test" 06:08:42 INFO - } 06:08:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 06:08:42 INFO - Running post-action listener: _resource_record_post_action 06:08:42 INFO - ##### 06:08:42 INFO - ##### Running download-and-extract step. 06:08:42 INFO - ##### 06:08:42 INFO - Running pre-action listener: _resource_record_pre_action 06:08:42 INFO - Running main action method: download_and_extract 06:08:42 INFO - mkdir: /builds/slave/test/build/tests 06:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:42 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:08:43 INFO - Downloaded 1412 bytes. 06:08:43 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 06:08:43 INFO - Using the following test package requirements: 06:08:43 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:08:43 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:08:43 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:08:43 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:08:43 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 06:08:43 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:08:43 INFO - u'jsshell-linux-x86_64.zip'], 06:08:43 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:08:43 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:08:43 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:08:43 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:08:43 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 06:08:43 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:08:43 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 06:08:43 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:08:43 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:08:43 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 06:08:43 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 06:08:43 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:08:43 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:43 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:08:45 INFO - Downloaded 23364641 bytes. 06:08:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:08:46 INFO - Return code: 0 06:08:46 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:46 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 06:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:08:47 INFO - Downloaded 23364641 bytes. 06:08:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:08:49 INFO - Return code: 0 06:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:49 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 06:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:08:50 INFO - Downloaded 10845194 bytes. 06:08:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:08:50 INFO - Return code: 0 06:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:50 INFO - https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:08:51 INFO - Downloaded 53795175 bytes. 06:08:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:08:51 INFO - mkdir: /builds/slave/test/properties 06:08:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:08:51 INFO - Writing to file /builds/slave/test/properties/build_url 06:08:51 INFO - Contents: 06:08:51 INFO - build_url:https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 06:08:52 INFO - Running post-action listener: _resource_record_post_action 06:08:52 INFO - Running post-action listener: set_extra_try_arguments 06:08:52 INFO - ##### 06:08:52 INFO - ##### Running populate-webroot step. 06:08:52 INFO - ##### 06:08:52 INFO - Running pre-action listener: _resource_record_pre_action 06:08:52 INFO - Running main action method: populate_webroot 06:08:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:08:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:08:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:08:52 INFO - '--tppagecycles', 06:08:52 INFO - '7'], 06:08:52 INFO - 'tests': ['tsvgm']}}, 06:08:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:08:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:08:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:08:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:08:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:08:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:08:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:52 INFO - 'talos_options': ['--e10s'], 06:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:52 INFO - 'tests': ['damp', 'tps']}, 06:08:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:52 INFO - 'talos_options': ['--e10s'], 06:08:52 INFO - 'tests': ['damp', 'tps']}, 06:08:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:08:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:08:52 INFO - 'other': {'tests': ['a11yr', 06:08:52 INFO - 'ts_paint', 06:08:52 INFO - 'tpaint', 06:08:52 INFO - 'sessionrestore', 06:08:52 INFO - 'sessionrestore_no_auto_restore', 06:08:52 INFO - 'tabpaint']}, 06:08:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:08:52 INFO - 'tests': ['a11yr', 06:08:52 INFO - 'ts_paint', 06:08:52 INFO - 'tpaint', 06:08:52 INFO - 'sessionrestore', 06:08:52 INFO - 'sessionrestore_no_auto_restore', 06:08:52 INFO - 'tabpaint']}, 06:08:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:08:52 INFO - 'tests': ['a11yr', 06:08:52 INFO - 'ts_paint', 06:08:52 INFO - 'tpaint', 06:08:52 INFO - 'sessionrestore', 06:08:52 INFO - 'sessionrestore_no_auto_restore', 06:08:52 INFO - 'tabpaint']}, 06:08:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:08:52 INFO - 'tests': ['a11yr', 06:08:52 INFO - 'ts_paint', 06:08:52 INFO - 'tpaint', 06:08:52 INFO - 'sessionrestore', 06:08:52 INFO - 'sessionrestore_no_auto_restore', 06:08:52 INFO - 'tabpaint']}, 06:08:52 INFO - 'other_l64': {'tests': ['a11yr', 06:08:52 INFO - 'ts_paint', 06:08:52 INFO - 'tpaint', 06:08:52 INFO - 'sessionrestore', 06:08:52 INFO - 'sessionrestore_no_auto_restore', 06:08:52 INFO - 'tabpaint']}, 06:08:52 INFO - 'other_nol64': {'tests': ['a11yr', 06:08:52 INFO - 'ts_paint', 06:08:52 INFO - 'tpaint', 06:08:52 INFO - 'sessionrestore', 06:08:52 INFO - 'sessionrestore_no_auto_restore', 06:08:52 INFO - 'tabpaint']}, 06:08:52 INFO - 'svgr': {'tests': ['tsvgx', 06:08:52 INFO - 'tsvgr_opacity', 06:08:52 INFO - 'tart', 06:08:52 INFO - 'tscrollx', 06:08:52 INFO - 'cart']}, 06:08:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:08:52 INFO - 'tests': ['tsvgx', 06:08:52 INFO - 'tsvgr_opacity', 06:08:52 INFO - 'tart', 06:08:52 INFO - 'tscrollx', 06:08:52 INFO - 'cart']}, 06:08:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:52 INFO - 'tests': ['tp5o']}, 06:08:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:52 INFO - 'talos_options': ['--e10s'], 06:08:52 INFO - 'tests': ['tp5o']}, 06:08:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:52 INFO - 'talos_options': ['--xperf_path', 06:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:52 INFO - 'tests': ['tp5n']}, 06:08:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:52 INFO - 'talos_options': ['--e10s', 06:08:52 INFO - '--xperf_path', 06:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:52 INFO - 'tests': ['tp5n']}}, 06:08:52 INFO - 'talos.zip': {'path': '', 06:08:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:08:52 INFO - Running post-action listener: _resource_record_post_action 06:08:52 INFO - ##### 06:08:52 INFO - ##### Running create-virtualenv step. 06:08:52 INFO - ##### 06:08:52 INFO - Running pre-action listener: _resource_record_pre_action 06:08:52 INFO - Running main action method: create_virtualenv 06:08:52 INFO - Creating virtualenv /builds/slave/test/build/venv 06:08:52 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 06:08:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:08:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:08:52 INFO - Using real prefix '/usr' 06:08:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:08:53 INFO - Installing distribute.............................................................................................................................................................................................done. 06:08:55 INFO - Installing pip.................done. 06:08:55 INFO - Return code: 0 06:08:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef891c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22333c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, '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': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', '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 06:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:08:55 INFO - Using env: {'DISPLAY': ':0', 06:08:55 INFO - 'HOME': '/home/cltbld', 06:08:55 INFO - 'LANG': 'en_US.UTF-8', 06:08:55 INFO - 'LANGUAGE': 'en_US:en', 06:08:55 INFO - 'LOGNAME': 'cltbld', 06:08:55 INFO - 'MAIL': '/var/mail/cltbld', 06:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:55 INFO - 'MOZ_NO_REMOTE': '1', 06:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:55 INFO - 'NO_EM_RESTART': '1', 06:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:55 INFO - 'PWD': '/builds/slave/test', 06:08:55 INFO - 'SHELL': '/bin/bash', 06:08:55 INFO - 'SHLVL': '1', 06:08:55 INFO - 'TERM': 'linux', 06:08:55 INFO - 'TMOUT': '86400', 06:08:55 INFO - 'USER': 'cltbld', 06:08:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:55 INFO - '_': '/tools/buildbot/bin/python'} 06:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:55 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 06:08:55 INFO - Cleaning up... 06:08:55 INFO - Return code: 0 06:08:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef891c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22333c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, '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': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', '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 06:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:08:55 INFO - Using env: {'DISPLAY': ':0', 06:08:55 INFO - 'HOME': '/home/cltbld', 06:08:55 INFO - 'LANG': 'en_US.UTF-8', 06:08:55 INFO - 'LANGUAGE': 'en_US:en', 06:08:55 INFO - 'LOGNAME': 'cltbld', 06:08:55 INFO - 'MAIL': '/var/mail/cltbld', 06:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:55 INFO - 'MOZ_NO_REMOTE': '1', 06:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:55 INFO - 'NO_EM_RESTART': '1', 06:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:55 INFO - 'PWD': '/builds/slave/test', 06:08:55 INFO - 'SHELL': '/bin/bash', 06:08:55 INFO - 'SHLVL': '1', 06:08:55 INFO - 'TERM': 'linux', 06:08:55 INFO - 'TMOUT': '86400', 06:08:55 INFO - 'USER': 'cltbld', 06:08:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:55 INFO - '_': '/tools/buildbot/bin/python'} 06:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:55 INFO - Downloading/unpacking psutil>=0.7.1 06:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:57 INFO - Installing collected packages: psutil 06:08:57 INFO - Running setup.py install for psutil 06:08:57 INFO - building 'psutil._psutil_linux' extension 06:08:57 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 06:08:57 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 06:08:57 INFO - building 'psutil._psutil_posix' extension 06:08:57 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 06:08:57 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 06:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:57 INFO - Successfully installed psutil 06:08:57 INFO - Cleaning up... 06:08:58 INFO - Return code: 0 06:08:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef891c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22333c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, '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': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', '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 06:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:08:58 INFO - Using env: {'DISPLAY': ':0', 06:08:58 INFO - 'HOME': '/home/cltbld', 06:08:58 INFO - 'LANG': 'en_US.UTF-8', 06:08:58 INFO - 'LANGUAGE': 'en_US:en', 06:08:58 INFO - 'LOGNAME': 'cltbld', 06:08:58 INFO - 'MAIL': '/var/mail/cltbld', 06:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:58 INFO - 'MOZ_NO_REMOTE': '1', 06:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:58 INFO - 'NO_EM_RESTART': '1', 06:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:58 INFO - 'PWD': '/builds/slave/test', 06:08:58 INFO - 'SHELL': '/bin/bash', 06:08:58 INFO - 'SHLVL': '1', 06:08:58 INFO - 'TERM': 'linux', 06:08:58 INFO - 'TMOUT': '86400', 06:08:58 INFO - 'USER': 'cltbld', 06:08:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:58 INFO - '_': '/tools/buildbot/bin/python'} 06:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:09:00 INFO - Installing collected packages: mozsystemmonitor 06:09:00 INFO - Running setup.py install for mozsystemmonitor 06:09:00 INFO - Successfully installed mozsystemmonitor 06:09:00 INFO - Cleaning up... 06:09:00 INFO - Return code: 0 06:09:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:00 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 0x7fef891c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22333c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, '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': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', '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 06:09:00 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 06:09:00 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 06:09:00 INFO - Using env: {'DISPLAY': ':0', 06:09:00 INFO - 'HOME': '/home/cltbld', 06:09:00 INFO - 'LANG': 'en_US.UTF-8', 06:09:00 INFO - 'LANGUAGE': 'en_US:en', 06:09:00 INFO - 'LOGNAME': 'cltbld', 06:09:00 INFO - 'MAIL': '/var/mail/cltbld', 06:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:00 INFO - 'MOZ_NO_REMOTE': '1', 06:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:00 INFO - 'NO_EM_RESTART': '1', 06:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:00 INFO - 'PWD': '/builds/slave/test', 06:09:00 INFO - 'SHELL': '/bin/bash', 06:09:00 INFO - 'SHLVL': '1', 06:09:00 INFO - 'TERM': 'linux', 06:09:00 INFO - 'TMOUT': '86400', 06:09:00 INFO - 'USER': 'cltbld', 06:09:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:00 INFO - '_': '/tools/buildbot/bin/python'} 06:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:00 INFO - Downloading/unpacking blobuploader==1.2.4 06:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:02 INFO - Downloading blobuploader-1.2.4.tar.gz 06:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:09:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:09:02 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 06:09:02 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 06:09:02 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 06:09:02 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 06:09:02 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 06:09:02 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 06:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:09:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:09:02 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 06:09:02 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 06:09:02 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 06:09:02 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 06:09:02 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 06:09:02 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 06:09:03 INFO - Downloading docopt-0.6.1.tar.gz 06:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:09:03 INFO - Installing collected packages: blobuploader, requests, docopt 06:09:03 INFO - Running setup.py install for blobuploader 06:09:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:09:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:09:03 INFO - Running setup.py install for requests 06:09:03 INFO - Running setup.py install for docopt 06:09:03 INFO - Successfully installed blobuploader requests docopt 06:09:03 INFO - Cleaning up... 06:09:03 INFO - Return code: 0 06:09:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09:03 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')]} 06:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:03 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')]} 06:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:03 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 0x7fef891c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22333c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, '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': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', '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 06:09:03 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 06:09:03 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 06:09:03 INFO - Using env: {'DISPLAY': ':0', 06:09:03 INFO - 'HOME': '/home/cltbld', 06:09:03 INFO - 'LANG': 'en_US.UTF-8', 06:09:03 INFO - 'LANGUAGE': 'en_US:en', 06:09:03 INFO - 'LOGNAME': 'cltbld', 06:09:03 INFO - 'MAIL': '/var/mail/cltbld', 06:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:03 INFO - 'MOZ_NO_REMOTE': '1', 06:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:03 INFO - 'NO_EM_RESTART': '1', 06:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:03 INFO - 'PWD': '/builds/slave/test', 06:09:03 INFO - 'SHELL': '/bin/bash', 06:09:03 INFO - 'SHLVL': '1', 06:09:03 INFO - 'TERM': 'linux', 06:09:03 INFO - 'TMOUT': '86400', 06:09:03 INFO - 'USER': 'cltbld', 06:09:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:03 INFO - '_': '/tools/buildbot/bin/python'} 06:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:09:04 INFO - Running setup.py (path:/tmp/pip-0N9h61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:09:04 INFO - Running setup.py (path:/tmp/pip-pq0din-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:09:04 INFO - Running setup.py (path:/tmp/pip-kpAiQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:09:04 INFO - Running setup.py (path:/tmp/pip-BBIToq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:09:04 INFO - Running setup.py (path:/tmp/pip-kWKXE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:09:04 INFO - Running setup.py (path:/tmp/pip-585Qij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:09:04 INFO - Running setup.py (path:/tmp/pip-9yE4Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:09:04 INFO - Running setup.py (path:/tmp/pip-Wp1cic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:09:04 INFO - Running setup.py (path:/tmp/pip-f0tsqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:09:04 INFO - Running setup.py (path:/tmp/pip-XrEG39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:09:04 INFO - Running setup.py (path:/tmp/pip-d0Isxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:09:04 INFO - Running setup.py (path:/tmp/pip-gB3Z35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:09:04 INFO - Running setup.py (path:/tmp/pip-1WPwu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:09:04 INFO - Running setup.py (path:/tmp/pip-7nx6Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:05 INFO - Running setup.py (path:/tmp/pip-cEm3n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:09:05 INFO - Running setup.py (path:/tmp/pip-Ja5dpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:09:05 INFO - Running setup.py (path:/tmp/pip-xLyvAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:09:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:09:05 INFO - Running setup.py install for manifestparser 06:09:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:09:05 INFO - Running setup.py install for mozcrash 06:09:05 INFO - Running setup.py install for mozdebug 06:09:05 INFO - Running setup.py install for mozdevice 06:09:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:09:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:09:05 INFO - Running setup.py install for mozfile 06:09:05 INFO - Running setup.py install for mozhttpd 06:09:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:09:05 INFO - Running setup.py install for mozinfo 06:09:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:09:05 INFO - Running setup.py install for mozInstall 06:09:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Running setup.py install for mozleak 06:09:06 INFO - Running setup.py install for mozlog 06:09:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Running setup.py install for moznetwork 06:09:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Running setup.py install for mozprocess 06:09:06 INFO - Running setup.py install for mozprofile 06:09:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Running setup.py install for mozrunner 06:09:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Running setup.py install for mozscreenshot 06:09:06 INFO - Running setup.py install for moztest 06:09:06 INFO - Running setup.py install for mozversion 06:09:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:09:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:09:06 INFO - Cleaning up... 06:09:07 INFO - Return code: 0 06:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06: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')]} 06:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:07 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 0x7fef891c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22333c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, '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': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', '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 06:09:07 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 06:09:07 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 06:09:07 INFO - Using env: {'DISPLAY': ':0', 06:09:07 INFO - 'HOME': '/home/cltbld', 06:09:07 INFO - 'LANG': 'en_US.UTF-8', 06:09:07 INFO - 'LANGUAGE': 'en_US:en', 06:09:07 INFO - 'LOGNAME': 'cltbld', 06:09:07 INFO - 'MAIL': '/var/mail/cltbld', 06:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:07 INFO - 'MOZ_NO_REMOTE': '1', 06:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:07 INFO - 'NO_EM_RESTART': '1', 06:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:07 INFO - 'PWD': '/builds/slave/test', 06:09:07 INFO - 'SHELL': '/bin/bash', 06:09:07 INFO - 'SHLVL': '1', 06:09:07 INFO - 'TERM': 'linux', 06:09:07 INFO - 'TMOUT': '86400', 06:09:07 INFO - 'USER': 'cltbld', 06:09:07 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:07 INFO - '_': '/tools/buildbot/bin/python'} 06:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:09:07 INFO - Running setup.py (path:/tmp/pip-CsZfse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:09:07 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:09:07 INFO - Running setup.py (path:/tmp/pip-NJVRIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:09:07 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:09:07 INFO - Running setup.py (path:/tmp/pip-DV_WOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:09:07 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:09:07 INFO - Running setup.py (path:/tmp/pip-QGmLCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:09:07 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:09:07 INFO - Running setup.py (path:/tmp/pip-Vh56db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:09:07 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:09:07 INFO - Running setup.py (path:/tmp/pip-Lcro0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:09:07 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:09:07 INFO - Running setup.py (path:/tmp/pip-UCtnm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:09:07 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:09:07 INFO - Running setup.py (path:/tmp/pip-4y9Bab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:09:07 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:09:07 INFO - Running setup.py (path:/tmp/pip-TtXbj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:09:07 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:09:07 INFO - Running setup.py (path:/tmp/pip-DedN1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 06:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:09:07 INFO - Running setup.py (path:/tmp/pip-D3bgZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:09:08 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)) 06:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:09:08 INFO - Running setup.py (path:/tmp/pip-52wUCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 06:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:09:08 INFO - Running setup.py (path:/tmp/pip-D5tE5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:09:08 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)) 06:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:09:08 INFO - Running setup.py (path:/tmp/pip-mmKNsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 06:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:08 INFO - Running setup.py (path:/tmp/pip-GHE85B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:08 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)) 06:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:09:08 INFO - Running setup.py (path:/tmp/pip-Ft7Y2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:09:08 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)) 06:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:09:08 INFO - Running setup.py (path:/tmp/pip-qU3BGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:09:08 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)) 06:09:08 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)) 06:09:08 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)) 06:09:08 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)) 06:09:08 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)) 06:09:08 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)) 06:09:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:09:08 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 06:09:08 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 06:09:08 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 06:09:08 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 06:09:08 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 06:09:08 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 06:09:10 INFO - Downloading blessings-1.6.tar.gz 06:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:09:10 INFO - Installing collected packages: blessings 06:09:10 INFO - Running setup.py install for blessings 06:09:10 INFO - Successfully installed blessings 06:09:10 INFO - Cleaning up... 06:09:10 INFO - Return code: 0 06:09:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:09:10 INFO - Reading from file tmpfile_stdout 06:09:10 INFO - Current package versions: 06:09:10 INFO - argparse == 1.2.1 06:09:10 INFO - blessings == 1.6 06:09:10 INFO - blobuploader == 1.2.4 06:09:10 INFO - docopt == 0.6.1 06:09:10 INFO - manifestparser == 1.1 06:09:10 INFO - mozInstall == 1.12 06:09:10 INFO - mozcrash == 0.17 06:09:10 INFO - mozdebug == 0.1 06:09:10 INFO - mozdevice == 0.48 06:09:10 INFO - mozfile == 1.2 06:09:10 INFO - mozhttpd == 0.7 06:09:10 INFO - mozinfo == 0.9 06:09:10 INFO - mozleak == 0.1 06:09:10 INFO - mozlog == 3.1 06:09:10 INFO - moznetwork == 0.27 06:09:10 INFO - mozprocess == 0.22 06:09:10 INFO - mozprofile == 0.28 06:09:10 INFO - mozrunner == 6.11 06:09:10 INFO - mozscreenshot == 0.1 06:09:10 INFO - mozsystemmonitor == 0.0 06:09:10 INFO - moztest == 0.7 06:09:10 INFO - mozversion == 1.4 06:09:10 INFO - psutil == 3.1.1 06:09:10 INFO - requests == 1.2.3 06:09:10 INFO - wsgiref == 0.1.2 06:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:10 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 0x7fef891c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22333c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, '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': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', '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 06:09:10 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 06:09:10 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 06:09:10 INFO - Using env: {'DISPLAY': ':0', 06:09:10 INFO - 'HOME': '/home/cltbld', 06:09:10 INFO - 'LANG': 'en_US.UTF-8', 06:09:10 INFO - 'LANGUAGE': 'en_US:en', 06:09:10 INFO - 'LOGNAME': 'cltbld', 06:09:10 INFO - 'MAIL': '/var/mail/cltbld', 06:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:10 INFO - 'MOZ_NO_REMOTE': '1', 06:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:10 INFO - 'NO_EM_RESTART': '1', 06:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:10 INFO - 'PWD': '/builds/slave/test', 06:09:10 INFO - 'SHELL': '/bin/bash', 06:09:10 INFO - 'SHLVL': '1', 06:09:10 INFO - 'TERM': 'linux', 06:09:10 INFO - 'TMOUT': '86400', 06:09:10 INFO - 'USER': 'cltbld', 06:09:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:10 INFO - '_': '/tools/buildbot/bin/python'} 06:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:11 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)) 06:09:11 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)) 06:09:11 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)) 06:09:11 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)) 06:09:11 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)) 06:09:11 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)) 06:09:11 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)) 06:09:11 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)) 06:09:11 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)) 06:09:11 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)) 06:09:11 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)) 06:09:11 INFO - Cleaning up... 06:09:11 INFO - Return code: 0 06:09:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:09:11 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')]} 06:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:11 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')]} 06:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:11 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 0x7fef891c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22333c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, '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': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', '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 06:09:11 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 06:09:11 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 06:09:11 INFO - Using env: {'DISPLAY': ':0', 06:09:11 INFO - 'HOME': '/home/cltbld', 06:09:11 INFO - 'LANG': 'en_US.UTF-8', 06:09:11 INFO - 'LANGUAGE': 'en_US:en', 06:09:11 INFO - 'LOGNAME': 'cltbld', 06:09:11 INFO - 'MAIL': '/var/mail/cltbld', 06:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:11 INFO - 'MOZ_NO_REMOTE': '1', 06:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:11 INFO - 'NO_EM_RESTART': '1', 06:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:11 INFO - 'PWD': '/builds/slave/test', 06:09:11 INFO - 'SHELL': '/bin/bash', 06:09:11 INFO - 'SHLVL': '1', 06:09:11 INFO - 'TERM': 'linux', 06:09:11 INFO - 'TMOUT': '86400', 06:09:11 INFO - 'USER': 'cltbld', 06:09:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:11 INFO - '_': '/tools/buildbot/bin/python'} 06:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:11 INFO - Downloading/unpacking jsonschema 06:09:11 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 06:09:11 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 06:09:11 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 06:09:11 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 06:09:11 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 06:09:11 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 06:09:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:09:13 INFO - Downloading/unpacking functools32 (from jsonschema) 06:09:13 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 06:09:13 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 06:09:13 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 06:09:13 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 06:09:13 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 06:09:13 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 06:09:13 INFO - Downloading functools32-3.2.3-2.tar.gz 06:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:09:13 INFO - warning: no files found matching '*.txt' 06:09:13 INFO - no previously-included directories found matching 'build' 06:09:13 INFO - no previously-included directories found matching 'dist' 06:09:13 INFO - no previously-included directories found matching '.git*' 06:09:13 INFO - Installing collected packages: jsonschema, functools32 06:09:13 INFO - Running setup.py install for functools32 06:09:13 INFO - warning: no files found matching '*.txt' 06:09:13 INFO - no previously-included directories found matching 'build' 06:09:13 INFO - no previously-included directories found matching 'dist' 06:09:13 INFO - no previously-included directories found matching '.git*' 06:09:13 INFO - Successfully installed jsonschema functools32 06:09:13 INFO - Cleaning up... 06:09:13 INFO - Return code: 0 06:09:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:09:13 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')]} 06:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:13 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')]} 06:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:13 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef891c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22333c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, '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': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', '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 06:09:13 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', 'flake8'] in /builds/slave/test/build 06:09:13 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 flake8 06:09:13 INFO - Using env: {'DISPLAY': ':0', 06:09:13 INFO - 'HOME': '/home/cltbld', 06:09:13 INFO - 'LANG': 'en_US.UTF-8', 06:09:13 INFO - 'LANGUAGE': 'en_US:en', 06:09:13 INFO - 'LOGNAME': 'cltbld', 06:09:13 INFO - 'MAIL': '/var/mail/cltbld', 06:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:13 INFO - 'MOZ_NO_REMOTE': '1', 06:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:13 INFO - 'NO_EM_RESTART': '1', 06:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:13 INFO - 'PWD': '/builds/slave/test', 06:09:13 INFO - 'SHELL': '/bin/bash', 06:09:13 INFO - 'SHLVL': '1', 06:09:13 INFO - 'TERM': 'linux', 06:09:13 INFO - 'TMOUT': '86400', 06:09:13 INFO - 'USER': 'cltbld', 06:09:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:13 INFO - '_': '/tools/buildbot/bin/python'} 06:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:13 INFO - Downloading/unpacking flake8 06:09:13 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 06:09:13 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 06:09:13 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 06:09:13 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 06:09:13 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 06:09:13 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 06:09:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:09:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:09:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:09:16 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 06:09:16 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 06:09:16 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 06:09:16 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 06:09:16 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 06:09:16 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 06:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:09:16 INFO - no previously-included directories found matching 'docs/_build' 06:09:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:09:16 INFO - Running setup.py install for pep8 06:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:09:16 INFO - no previously-included directories found matching 'docs/_build' 06:09:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:09:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:09:16 INFO - Cleaning up... 06:09:16 INFO - Return code: 0 06:09:16 INFO - Running post-action listener: _resource_record_post_action 06:09:16 INFO - Running post-action listener: _start_resource_monitoring 06:09:16 INFO - Starting resource monitoring. 06:09:16 INFO - ##### 06:09:16 INFO - ##### Running install step. 06:09:16 INFO - ##### 06:09:16 INFO - Running pre-action listener: _resource_record_pre_action 06:09:16 INFO - Running main action method: install 06:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:09:16 INFO - Reading from file tmpfile_stdout 06:09:16 INFO - Detecting whether we're running mozinstall >=1.0... 06:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:09:16 INFO - Reading from file tmpfile_stdout 06:09:16 INFO - Output received: 06:09:16 INFO - Usage: mozinstall [options] installer 06:09:16 INFO - Options: 06:09:16 INFO - -h, --help show this help message and exit 06:09:16 INFO - -d DEST, --destination=DEST 06:09:16 INFO - Directory to install application into. [default: 06:09:16 INFO - "/builds/slave/test"] 06:09:16 INFO - --app=APP Application being installed. [default: firefox] 06:09:16 INFO - mkdir: /builds/slave/test/build/application 06:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:09:29 INFO - Reading from file tmpfile_stdout 06:09:29 INFO - Output received: 06:09:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:09:29 INFO - Running post-action listener: _resource_record_post_action 06:09:29 INFO - ##### 06:09:29 INFO - ##### Running run-tests step. 06:09:29 INFO - ##### 06:09:29 INFO - Running pre-action listener: _resource_record_pre_action 06:09:29 INFO - Running main action method: run_tests 06:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:09:29 INFO - Python 2.7.3 06:09:29 INFO - Return code: 0 06:09:29 INFO - grabbing minidump binary from tooltool 06:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230580>, '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 0x2231480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:09:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:09:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:09:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:09:29 INFO - Return code: 0 06:09:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:09:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:09:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:09:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:09:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:09:30 INFO - Return code: 0 06:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 06:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 06:09:30 INFO - Using env: {'DISPLAY': ':0', 06:09:30 INFO - 'HOME': '/home/cltbld', 06:09:30 INFO - 'LANG': 'en_US.UTF-8', 06:09:30 INFO - 'LANGUAGE': 'en_US:en', 06:09:30 INFO - 'LOGNAME': 'cltbld', 06:09:30 INFO - 'MAIL': '/var/mail/cltbld', 06:09:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:09:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:30 INFO - 'MOZ_NO_REMOTE': '1', 06:09:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:30 INFO - 'NO_EM_RESTART': '1', 06:09:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:30 INFO - 'PWD': '/builds/slave/test', 06:09:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:09:30 INFO - 'SHELL': '/bin/bash', 06:09:30 INFO - 'SHLVL': '1', 06:09:30 INFO - 'TERM': 'linux', 06:09:30 INFO - 'TMOUT': '86400', 06:09:30 INFO - 'USER': 'cltbld', 06:09:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220', 06:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:30 INFO - '_': '/tools/buildbot/bin/python'} 06:09:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 06:09:30 INFO - mozversion application_buildid: 20160506162552 06:09:30 INFO - mozversion application_changeset: 025d85d8686491f7975b9d2e86b97180e3f9e0fa 06:09:30 INFO - mozversion application_display_name: Firefox 06:09:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:09:30 INFO - mozversion application_name: Firefox 06:09:30 INFO - mozversion application_remotingname: firefox 06:09:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:09:30 INFO - mozversion application_vendor: Mozilla 06:09:30 INFO - mozversion application_version: 47.0 06:09:30 INFO - mozversion platform_buildid: 20160506162552 06:09:30 INFO - mozversion platform_changeset: 025d85d8686491f7975b9d2e86b97180e3f9e0fa 06:09:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:09:30 INFO - mozversion platform_version: 47.0 06:09:30 INFO - using testdate: 1462799370 06:09:30 INFO - actual date: 1462799370 06:09:30 INFO - starting webserver on 'localhost:49516' 06:09:30 INFO - SUITE-START | Running 2 tests 06:09:30 INFO - TEST-START | dromaeo_css 06:09:30 INFO - operating with platform_type : linux_ 06:09:30 INFO - Initialising browser for dromaeo_css test... 06:09:30 INFO - TEST-INFO | started process 9912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PTmD7/profile http://localhost:49516/getInfo.html) 06:09:34 INFO - PROCESS | 9912 | __metrics Screen width/height:1600/1200 06:09:34 INFO - PROCESS | 9912 | colorDepth:24 06:09:34 INFO - PROCESS | 9912 | Browser inner width/height: 1024/697 06:09:34 INFO - PROCESS | 9912 | __metrics 06:09:35 INFO - PROCESS | 9912 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:09:36 INFO - TEST-INFO | 9912: exit 0 06:09:36 INFO - Browser initialized. 06:09:36 INFO - Running cycle 1/1 for dromaeo_css test... 06:09:36 INFO - TEST-INFO | started process 10002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PTmD7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:48 INFO - PROCESS | 10002 | RSS: Main: 139571200 06:09:48 INFO - PROCESS | 10002 | 06:10:39 INFO - PROCESS | 10002 | 1462799439600 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] 06:12:46 INFO - PROCESS | 10002 | Cycle 1(1): loaded http://localhost:49516/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49516/tests/dromaeo/cssquery-ext.html) 06:12:47 INFO - PROCESS | 10002 | RSS: Main: 257048576 06:12:47 INFO - PROCESS | 10002 | 06:15:50 INFO - PROCESS | 10002 | Cycle 1(1): loaded http://localhost:49516/tests/dromaeo/cssquery-ext.html (next: http://localhost:49516/tests/dromaeo/cssquery-jquery.html) 06:15:50 INFO - PROCESS | 10002 | RSS: Main: 228024320 06:15:50 INFO - PROCESS | 10002 | 06:18:52 INFO - PROCESS | 10002 | Cycle 1(1): loaded http://localhost:49516/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49516/tests/dromaeo/cssquery-mootools.html) 06:18:52 INFO - PROCESS | 10002 | RSS: Main: 217518080 06:18:52 INFO - PROCESS | 10002 | 06:21:54 INFO - PROCESS | 10002 | Cycle 1(1): loaded http://localhost:49516/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49516/tests/dromaeo/cssquery-prototype.html) 06:21:55 INFO - PROCESS | 10002 | RSS: Main: 193388544 06:21:55 INFO - PROCESS | 10002 | 06:24:57 INFO - PROCESS | 10002 | Cycle 1(1): loaded http://localhost:49516/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49516/tests/dromaeo/cssquery-yui.html) 06:24:58 INFO - PROCESS | 10002 | RSS: Main: 211701760 06:24:58 INFO - PROCESS | 10002 | 06:28:00 INFO - PROCESS | 10002 | Cycle 1(1): loaded http://localhost:49516/tests/dromaeo/cssquery-yui.html (next: http://localhost:49516/tests/dromaeo/cssquery-dojo.html) 06:28:00 INFO - PROCESS | 10002 | RSS: Main: 233873408 06:28:00 INFO - PROCESS | 10002 | 06:28:00 INFO - PROCESS | 10002 | __start_tp_report 06:28:00 INFO - PROCESS | 10002 | _x_x_mozilla_page_load 06:28:00 INFO - PROCESS | 10002 | _x_x_mozilla_page_load_details 06:28:00 INFO - PROCESS | 10002 | |i|pagename|runs| 06:28:00 INFO - PROCESS | 10002 | |0;dojo.html;3267.379197952389;3321.319129578438;3332.3668502984447;3353.0779035765163;3358.7313014958804;5355.08963476209;5360.169173778061;5365.087935051046;5370.597205209606;5386.461353864612;5362.597805164609;5380.865478363043;5392.352917649888;5404.972975135119;5422.1595652673805;4762.261849413347;4898.167311557035;4915.238138088602;4950.282209079682;5027.4972502749615;4922.926156107661;4993.151164302078;5023.748812559375;5023.773930173151;5025.246213068032;4927.6550641455115;4960.727160006199;5060.493950604947;5075.7715902784275;5078.7460626968505;5005.799768009275;5013.799448022075;5030.496950304977;5032.974835125838;5062.164742817449;4754.7147171169845;4830.782614782343;4911.312416261726;4924.60603151747;4947.678400903966;5213.947860521422;5241.780366804721;5242.397124330712;5255.264263003182;5284.022455845681;5730.255066841326;5759.769609215627;5811.418858114197;5814.447627475425;5828.504577110951;5797.913031304533;5801.506871915893;5804.187413762077;5805.767769289223;5817.680027598481;5437.02133615949;5438.211459338413;5438.2386465894415;5450.727463626803;5479.260299859548;5804.1293805929445;5838.2702162229725;5913.46778789911;5943.078822782476;5968.015277479168;5625;5649.830505084854;5654.74553645087;5662.915056274159;5670.546356291569;5752.050911599623;5756.597038207286;5762.337331206965;5769.798057068067;5774.393688662714;5719.056355701346;5790.276215473066;5850.736716847667;5874.148248503943;5894.498967587718;5819.214406055213;5830.5044071254415;5839.445252700986;5844.59087863854;5853.88292234153;4346.326319420495;4453.487848897418;4457.977710111429;4458.4426946631675;4496.910061798746;3941.3890846918775;3982.820773065219;3996.6403023728003;3997.400389941532;4023.979880100639;5475.945240547623;5476;5478.58910581708;5479.3424789024775;5484.095124304445;5728.79949201776;5771.88456230873;5807.680577568274;5807.88384232313;5824.213731146326;5557.72211389437;5563.221149039137;5586.24585680936;5596.188552659923;5625.915611265835;5065.214891691794;5065.898682026339;5066.240063990357;5067.366579177603;5087;5869;5988.850278743066;6079.08813677943;6096.756129754849;6116.052011938156;5864.618799778001;5871.089981052858;5872.647641141545;5877.118432235199;5877.73550190251;6056.788012419544;6069.089636554552;6071.696415179135;6081.361457047124;6085.817425477243;5658.236138121466;5726.226959360433;5776.393478684846;5794;5822.796202132905;5820.94179058204;5823.126531020381;5835.212246346859;5839.211706419579;5840.474357307863;5688.061469857427;5689.6586204827845;5691.174779657009;5695.601307908407;5696;5537.861553461195;5647.88704225905;5724.4561766632105;5755.8561035974435;5788.450097240755;5538.889222215453;5570.303712035996;5571.526420254324;5571.60998730085;5584.357798853184;5619.522340601095;5655.208270842003;5699.943000569941;5709;5714.3714191438075;5547.084731019498;5582.190582365615;5603.35561410443;5683.943160568341;5726.627769194989 06:28:00 INFO - PROCESS | 10002 | |1;ext.html;565.1494500776331;565.3187908570172;578.4909279833745;580.4137820800993;590.4154886662205;34850.82574587127;35697.82151089247;39321.803390983005;39933.600663993355;40042.39936400949;42909;43449.78275108628;43455.78272108643;43576.12847743043;43628;8858.557072146383;9065.18413342799;9065.22945549629;9065.546722663874;9068.229200517964;8904.465732056065;9023.233025192834;9032.954835225815;9036.954815225947;9045.276377889753;9267.25861931044;9329.67346142885;9359.625614975394;9362.531873406337;9364.953175234114;9163.129502697266;9215.539223038888;9238.58426370815;9240.445573265592;9241.122093401116;9147.359684822066;9269.397489163182;9279.67521136757;9283.953580232122;9286.396384235004;43366.783166084286;43650.12699746019;43692.781536092116;43706;43776.56223437757;3657.6708096271195;3839.520059992501;3920.647141757227;4099.938500922489;4267.63182229467;33160.834195829106;33501;33568.3286334272;34051.14872128192;34152.48771268433;4192.769397683126;4289.592488713567;4298.763568003758;4305.5048669402795;4347.3261644445165;297606;299744;299788.99999999785;300557;300944;46284.7685761569;66690;66890.66554667195;66899.33100668932;66942.33057669459;44885.551144488134;44901.55098448974;44934.77532612316;44979.77510112494;45123.54876451259;16093.195340232942;16391.180440977903;16408.67182656364;16416.261268242957;16448.34206631745;12797.936010319889;12900.419481123372;12900.548480803314;12904.290264035568;12912.483500659868;15569.766453503207;15661.84338156604;15995.600109997344;15999.200039997953;16044.598885027734;6016.639001659914;6069.757209711562;6148.569600127948;6164.815055548341;6232.56372053961;1096.2983690438125;1104.9337039777638;1150.5560521545408;1159.860816702001;1224.5897624295783;30683.539746903814;30930.381392372477;30981.8450907744;31074.68925310718;31346.373072538423;1082.3397727386289;1166.1603645375317;1183.3964678014274;1240.8635050144476;1285.4344088601172;16150.59623509398;16196.352145914267;16554.503364899072;16610.83389166093;16756;335454;512323;517953;520458;520800;56613;57060;57282;57350.42649573451;57431;1418.899057886895;1487.7693957436616;1489.3372449259975;1499.3253036133783;1502.774583812437;31399;32859.04779979128;32941.341173175926;33039.50440743439;33323.83338083391;46741;47186.764066180825;47412.288815668486;47466.28800568063;47475;238306;239337;248701;249292;249788;31023.224419389695;33071.66928330686;51082.74458627683;51538.22692659538;55133.448665512835;47951.5204847961;48207.75896120497;48786;48901.2664810021;49381.506184937694;39347.4260134295;39948;40140.59859401369;40140.99647508836;42335;41614.58385416107;41798.37302440405;42060.36909446299;42171.57828421677;43191.78404107959;41977.1604567913;42403.1519369617;42889.78555107329;43316.13367732565;43503.347449787645;37674.81162594169;37747.81126094352;37822.62177378301;37849.24301514009;38133;28471.145865624065;29109.85445072761;29182.56226156652;29326.26684332909;29434 06:28:00 INFO - PROCESS | 10002 | |2;jquery.html;387.7460263527387;390.980450977451;394.4379259555133;396.4212250114832;408.87120557024537;17768.20043098062;18298.817011829895;18299.268029278828;18306.908465457655;18509.167087481062;17857;18052.819471805276;18429.815701842977;18525.90737046313;18939.242430302773;5594.804181853636;5773.451522105393;5780.682062486561;5788.131780232957;5807.9419205808035;5628.352739434956;5667.4049224831415;5699.059655156894;5720.713964301789;5783.479486846183;5723.599348045638;5724.8282551523525;5726.226959360495;5731.226284451587;5735.827925162231;5558.888822223574;5623.550115990732;5698.772049118031;5701.315842098933;5714.7428365723645;5121.308623335839;5127.641065125443;5134.358205224347;5138.486151384869;5146.768395422215;21255.149794008223;22367;22501;22599.435014124614;22633.321000370015;2511.0332521978985;2567.3453269416177;2617.6727909011374;2712.213458097169;3020.1845501714415;10002;13549.187048777105;13601.591952241448;14044.087134336236;14166;1912.3593596145308;1957.5889063296725;1966.8131527505006;1969.9310524131586;1985.960280794376;68264;70282.64858675725;70442.64778676073;70607.64696176538;70908.64545677238;10557.841632375521;10690.251682382159;10762.78474430507;10835.295705779099;10958.835617465744;15404.845951540341;15465.613359666098;15484.986951696208;15494.5351639451;15521.767173492406;8093.109757926623;8171.387145963958;8193.50838949665;8229.341652667772;8292.419530632798;7986.880196797053;8076.798080048045;8127.065387480516;8183.877241841377;8202.630881610341;4140.44104045956;4348.5216626171095;4666.673332866667;4746.359241502353;4762.976185119052;1849.546861019059;1851.981480185181;1908.1508728615634;1950.141937547503;1954.9706754398696;918.2332752152028;931.7344556801414;992.8312186928096;1027.8715160604925;1053.1995683280609;17383.73924391135;17771.222877712386;17900;17994.64010719778;18063;960.1214888377057;1004.317064396203;1005.4369553050316;1018.7453136715822;1082.2694681090234;8678.826423471495;10013.148882344936;10043.397396156253;10414.16686665065;10491.213159013105;461028;463284;470398;474281;503471;82234;83281.58359208165;83534;83534.58232708798;84286;1044.2951008069674;1049.7119267791006;1075.6772968109692;1142.2175809570472;1145.777192247038;15913.204339783197;16376.426825061066;16408.17959102064;16517.504474865775;16668;35899.82050089733;36980.81509592435;37033;37339.439908400855;38459.80770096132;50593.74703126608;50677.74661126671;51224.23163652474;51319.230211547605;51600.22599661083;8524.70163544273;8672.609732562176;8797.12028797115;8875.689350872946;8897.911020889967;10185.898141018792;13386.062975592005;13579.59261222165;13584.592462226148;13586.796198057235;11618.76762464763;11681.824772628588;11696.766064678828;11899.345535995257;12037.45831437605;11775.470103845177;11867.347295898808;11884;11971.461284242056;12055.939720301343;10843.783124337628;11961.820572691242;12024.519019239482;12181.878181218075;12374.752504950031;8674.132586741527;8712.477251364939;8752.256058235122;8835.911640883509;8883.37816352849;10817.459127043774;10849;10953.890461095605;11013.704903995875;11347.319160850046 06:28:00 INFO - PROCESS | 10002 | |3;mootools.html;1458.6134674311315;1578.0373971877152;1614.2655091933173;1750.7023805952986;1830.5972686009081;8268.545230012347;8479.152084791518;8495.32037437005;8495.405321627488;8497.362697797675;8345.707900223493;8516.489010659365;8525.062243153263;8525.701600443987;8536.615852286646;2406.061635961976;2432.8297019208662;2437.9634305485433;2442.5725498037773;2444.2667199840066;2487.9751202488014;2496.8876400562017;2524.835885667426;2536;2543.4785868896925;2450.742672019439;2457.054034196838;2457.287386657867;2457.336519139831;2458.1027924807495;2371.1463873005705;2379.690640216778;2398.5442765874513;2463.9507209855883;2464.5933420985693;2466.13685210175;2483.0316176691103;2502.987485062581;2517.1567524879188;2520.231329444519;8481.830363392697;8538.573071346469;8541.701040463617;8599.097094805018;8677.392582519225;5196.740162991835;5373.194020896858;5411.56707463402;5415.10650742627;5421.972890135524;3203.6475987641575;3226.548283240348;3284.310294838087;3336.7497437692027;3348.2466445049913;1060.2790102730141;1061.4109169410974;1068.6206396729126;1076.9951834382064;1080.443571560647;11349;11556.88443115575;11565.595204167897;11566.768664626745;11570.247933884186;4506.774661266923;4518.367428560005;4603;4610.308453731967;4637.211674015425;9336.346455748168;9379.062093790566;9380.155785979157;9388.67139650109;9389.953050234704;5216.895662086813;5254.500822421864;5265.315508983884;5269.920951185735;5297.8145764898045;4315.4605674290715;4728.432588089451;4751.09729151467;4807.831725889577;4943.085529177042;3613.4760459733193;3661.9633803662155;3681.5582130144553;3687.0966613179944;3736.0286325555007;1102.6030628973563;1111.9777604447866;1112.9944350278358;1115.2026301194685;1126.8929451702074;1273.38877338876;1276.8786965238287;1343.7043850352907;1482.2959094430275;1512.296781996377;8095.473794203358;8260.421770476009;8283.544405057659;8289.8342033159;8296.70961516344;540.0441219042273;541.4071591607262;542.7204989430446;544.7793643574358;548.2434240747742;6156.630602163885;6167.537434692416;6178.814635560941;6181.474574661114;6237.4698150656795;10539.63111291101;10566.366018038789;10669.19981001428;10748.140148788078;10811.35131892089;10277.537510812032;10342.689719308433;10376.948115259376;10521.736956576147;10528.210384221215;8117.228863257981;8276.08963014068;8282.585870706562;8303.335733141334;8304.584770761438;7883.093444253984;7909.446338756232;7920.881186782318;8005.239502247277;8081;9434.905650943678;9473.526323683926;9607.423554586747;9674.467904265333;9676.709698708768;9671.806563868824;9761.707148785548;9883.752906177404;9927.702168934944;9945.950270248602;6263.812085637438;6823.590584564942;7034.402075823612;7071.186813516511;7166.8924966124505;8180.181981801772;8209.302209312036;8225.876611850947;8233.50598964064;8255.298299644597;7138.143422789299;7295.379892709179;7341.926580734124;7424.36892864091;7434.107907051189;7104.822379440556;7151.7854464366155;7155.606441645551;7249.166345870292;7325.560466372035;7902.407319451179;7906.841863162819;8002.51984880909;8014.519128852287;8014.799630009296;6743.325667433218;7201.675924583302;7252.673629686571;7263.564186148848;7263.564186148848;7187.532810367518;7243.927560724325;7244.927550724636;7251.5286506376915;7253.746118885813 06:28:00 INFO - PROCESS | 10002 | |4;prototype.html;339.5212750022468;339.86575302755415;345.0769192410303;345.18536254439533;355.46679980029955;6049.455549000594;6050.757969681213;6056.3338032816355;6107.511399088074;6114.1745864308305;5935.762569497215;5944.286685597724;5945.524358051356;5953.434423729749;5963.821085367446;4456.866294011169;4510.751908645023;4586;4634.980304333041;4635.976820115895;4605.769711514427;4624.8150073997;4630;4631.421072365954;4661.137689527432;4602.930956035662;4609.055143695535;4610.700304480215;4616.469106052813;4619.653525985547;4448.644108471331;4455.621272191867;4530.637548996106;4541.931871021938;4555.863324100283;3936.153726948691;3946.4080387941754;3950.644442000234;3952.110775075585;3958.050067983692;5702.800401985911;5722.256106706143;5733.799317023884;5739.282589676291;5742.196092547047;5226.137687281632;5247.317848679647;5248.816291429782;5257.526822585947;5262.2632831403635;6293.590916590407;6330.588511746721;6335.8416039598915;6339.429451349354;6340.112384266206;4295.4201182840225;4375.234333991539;4378.817719215794;4428.114377124556;4434;6604.2405123410945;6634.038064480672;6634.933650663528;6663.267040625576;6676.93323066768;4380.685794261773;4387.3857659927635;4388.868333949987;4396.560343965578;4396.626286765661;4449.86650400482;4457.465104187453;4458.08609235106;4460.665450091256;4462.3083422068985;5209.4009188943755;5210.452902445264;5211.244369566468;5217.452167522431;5218.739063046833;6333.524985626004;6353.7140828661895;6407.295197528269;6408.967955160194;6410.8717825643225;1587.0715631355556;1603.3666701652783;1609.49300970194;1609.8390160983809;1612.1455628516906;996.7458298133929;1020.9846852297221;1069.096613361708;1111.5053801058452;1188.922720023213;6150.07748837669;6163.876722465526;6169.043798211284;6173.41352571505;6191.226096737908;6548.083268342436;6556.63938483388;6558.639274839929;6559.967200163968;6566.737330506822;6180.134781130645;6187.752489900444;6194.287656919422;6194.752209911553;6196.597221180699;3503;3549.893503194908;3553.9822300888845;3554.129238336624;3555.5555555555557;6773.390394864486;6819.965900170567;6900.137482814648;6936.687849046805;6954.3045695431065;6796.592204467748;6806.149231346082;6815.863682726318;6817.420519255918;6832.248452670202;6892.862142757117;6903.6548172591165;6930.3762661360715;6980.7905762827195;7008.999999999898;6622.602643841385;6646.634435106115;6651.235107962452;6652.168478940132;6663.333666633298;6437.935620643921;6526.608403495806;6553.606783593;6554.31179726141;6563.278039415565;6851.2121106071445;6899.862002760017;6905.758298459731;6921.6193109379465;6926.653667316513;4619.422572178478;4648.093621743727;4662.277347011219;4663.253879379418;4665.043666048384;6644.800655980328;6649.800505984828;6651.301613330531;6657.40083392497;6665.900011499734;6330.208723909512;6452.741890324334;6466.159399278064;6474.838129046623;6478.060681201294;6443.838904027437;6481.157449531531;6493.610383377012;6495.870082598416;6503.577267477788;6318.842028949313;6323.241211054703;6327.082573026793;6328.525360597881;6333.1766870306565;6510;6510.121133646897;6515.837104072436;6524;6527;6031.09533569968;6091.329953705177;6332.841678957879;6358.650274234961;6373.426391624776 06:28:00 INFO - PROCESS | 10002 | |5;yui.html;822.9547374894386;856.5075081827947;857.6397912876591;909.8544232922734;949.3734135470587;15039.849601503982;15260;15269.847301526981;15282.847171528281;15287.464938727147;13971.510997115103;14043.438262469488;14092.859071409282;14127.293635318245;14653;927.9443233405983;934.56075644447;938.6010945348199;944.8204841080172;945.1871390604075;951.8619800128977;951.8619800128977;952.3714348529971;952.4570994533084;952.5570609666504;993.9055789699967;996.1930836022808;996.7508122969258;996.8305388084043;997.2122023601382;987.3976874106789;989.366805244644;989.6189966862773;990.4107056301525;994.2791476179748;726.6403130450461;730.2952650692055;730.3974221267475;731.042334541752;731.2249016043012;14207.36066876993;14234.217118058503;14246;14296;14296.285185740671;11639.301641901428;11745.354005529693;11914.46384912681;12353.073519485984;12427.93786031064;10780.137588992862;10916.07213386863;10993.175511836564;11012.834807477895;11337.206395552315;3907.27715372657;3959.3467077932105;3980.1641655252433;3981.5620281768984;3987.581303963071;46147.53852461466;46586.30120548195;51173;53264.467355326335;53816.192757109064;10397.012283833024;11102.056325212287;11598.594049208237;11615.59345422923;11760.647180584596;16481.83518164803;20336;20339.186432542534;20379.286724964553;20394;8365.498070115813;8393.874091888627;8437.493750374875;8530.488170709777;8533.402661813614;4617.5382461754225;4722.669413141116;4725.480197178307;4770.117528257283;4904.337914381585;3402.4385976314124;3449.741269404805;3454.1537323355938;3455.6544345565244;3456.70617997468;655.3577494055852;655.6262930129781;660.2275337854721;676.8409423785406;689.3141324382171;592.7895597063067;669.4142625202948;674.3290426026135;707.4517249131861;770.0374531835206;9866.408015519091;9931;10095.394276343295;10131.341462805041;10161.949190254001;669.1668872254074;728.4682182007165;745.5899255409612;748.1134855196609;764.4763337114094;4345.521992580813;4401.339799030107;4495.100979804052;4563.612092972135;4614.607758340579;57782;58359.4164058354;60110.69944650249;60138;60147.39852601506;44470.55529444729;50464;50612.240816387784;50625.49374506281;51404;46546;46831.531684683396;47147.764261178476;47675.284870726966;47932.28101578549;9535.76160595963;9597.184239339735;9766.560504777444;9870.457124858201;9875.753106172404;34808.65191348054;35067.82466087653;35223.82388088043;35765.1058723534;36603.63396366109;42257.366139508544;42785;45556.31665525086;46112;46780.29829552492;12337.321447320484;12380.195287306296;12496.125271230927;12509.74980500403;12633.620991370273;12597.93701031489;13353.198808071547;13690;13752.243626600633;13825.377857996615;12694.174878632859;13032;13210.141340812816;13555.186688798703;13665;12958.157719748186;13150.60548183556;13309.334533273104;13454.932725336703;13961.720765584834;12784.616461505797;12928.870711293142;13011.154274972096;13037.087403881636;13466;10515.421651808918;10530.526126324181;10877.456127193767;10999.670009899715;11058.502367393326;10800.24398292112;10859;10901.672949811518;10905.291156074829;11061.723456913642 06:28:00 INFO - PROCESS | 10002 | __end_tp_report 06:28:00 INFO - PROCESS | 10002 | __start_cc_report 06:28:00 INFO - PROCESS | 10002 | _x_x_mozilla_cycle_collect,895 06:28:00 INFO - PROCESS | 10002 | __end_cc_report 06:28:00 INFO - PROCESS | 10002 | __startTimestamp1462800480616__endTimestamp 06:28:00 INFO - PROCESS | 10002 | 06:28:00 INFO - PROCESS | 10002 | ------- Summary: start ------- 06:28:00 INFO - PROCESS | 10002 | Number of tests: 6 06:28:00 INFO - PROCESS | 10002 | 06:28:00 INFO - PROCESS | 10002 | [#0] dojo.html Cycles:165 Average:5404.76 Median:5603.36 stddev:589.47 (10.5%) stddev-sans-first:566.93 06:28:00 INFO - PROCESS | 10002 | Values: 3267.4 3321.3 3332.4 3353.1 3358.7 5355.1 5360.2 5365.1 5370.6 5386.5 5362.6 5380.9 5392.4 5405.0 5422.2 4762.3 4898.2 4915.2 4950.3 5027.5 4922.9 4993.2 5023.7 5023.8 5025.2 4927.7 4960.7 5060.5 5075.8 5078.7 5005.8 5013.8 5030.5 5033.0 5062.2 4754.7 4830.8 4911.3 4924.6 4947.7 5213.9 5241.8 5242.4 5255.3 5284.0 5730.3 5759.8 5811.4 5814.4 5828.5 5797.9 5801.5 5804.2 5805.8 5817.7 5437.0 5438.2 5438.2 5450.7 5479.3 5804.1 5838.3 5913.5 5943.1 5968.0 5625.0 5649.8 5654.7 5662.9 5670.5 5752.1 5756.6 5762.3 5769.8 5774.4 5719.1 5790.3 5850.7 5874.1 5894.5 5819.2 5830.5 5839.4 5844.6 5853.9 4346.3 4453.5 4458.0 4458.4 4496.9 3941.4 3982.8 3996.6 3997.4 4024.0 5475.9 5476.0 5478.6 5479.3 5484.1 5728.8 5771.9 5807.7 5807.9 5824.2 5557.7 5563.2 5586.2 5596.2 5625.9 5065.2 5065.9 5066.2 5067.4 5087.0 5869.0 5988.9 6079.1 6096.8 6116.1 5864.6 5871.1 5872.6 5877.1 5877.7 6056.8 6069.1 6071.7 6081.4 6085.8 5658.2 5726.2 5776.4 5794.0 5822.8 5820.9 5823.1 5835.2 5839.2 5840.5 5688.1 5689.7 5691.2 5695.6 5696.0 5537.9 5647.9 5724.5 5755.9 5788.5 5538.9 5570.3 5571.5 5571.6 5584.4 5619.5 5655.2 5699.9 5709.0 5714.4 5547.1 5582.2 5603.4 5683.9 5726.6 06:28:00 INFO - PROCESS | 10002 | 06:28:00 INFO - PROCESS | 10002 | [#1] ext.html Cycles:180 Average:52006.07 Median:42115.97 stddev:94983.71 (225.5%) stddev-sans-first:95171.64 06:28:00 INFO - PROCESS | 10002 | Values: 565.1 565.3 578.5 580.4 590.4 34850.8 35697.8 39321.8 39933.6 40042.4 42909.0 43449.8 43455.8 43576.1 43628.0 8858.6 9065.2 9065.2 9065.5 9068.2 8904.5 9023.2 9033.0 9037.0 9045.3 9267.3 9329.7 9359.6 9362.5 9365.0 9163.1 9215.5 9238.6 9240.4 9241.1 9147.4 9269.4 9279.7 9284.0 9286.4 43366.8 43650.1 43692.8 43706.0 43776.6 3657.7 3839.5 3920.6 4099.9 4267.6 33160.8 33501.0 33568.3 34051.1 34152.5 4192.8 4289.6 4298.8 4305.5 4347.3 297606.0 299744.0 299789.0 300557.0 300944.0 46284.8 66690.0 66890.7 66899.3 66942.3 44885.6 44901.6 44934.8 44979.8 45123.5 16093.2 16391.2 16408.7 16416.3 16448.3 12797.9 12900.4 12900.5 12904.3 12912.5 15569.8 15661.8 15995.6 15999.2 16044.6 6016.6 6069.8 6148.6 6164.8 6232.6 1096.3 1104.9 1150.6 1159.9 1224.6 30683.5 30930.4 30981.8 31074.7 31346.4 1082.3 1166.2 1183.4 1240.9 1285.4 16150.6 16196.4 16554.5 16610.8 16756.0 335454.0 512323.0 517953.0 520458.0 520800.0 56613.0 57060.0 57282.0 57350.4 57431.0 1418.9 1487.8 1489.3 1499.3 1502.8 31399.0 32859.0 32941.3 33039.5 33323.8 46741.0 47186.8 47412.3 47466.3 47475.0 238306.0 239337.0 248701.0 249292.0 249788.0 31023.2 33071.7 51082.7 51538.2 55133.4 47951.5 48207.8 48786.0 48901.3 49381.5 39347.4 39948.0 40140.6 40141.0 42335.0 41614.6 41798.4 42060.4 42171.6 43191.8 41977.2 42403.2 42889.8 43316.1 43503.3 37674.8 37747.8 37822.6 37849.2 38133.0 28471.1 29109.9 29182.6 29326.3 29434.0 06:28:00 INFO - PROCESS | 10002 | 06:28:00 INFO - PROCESS | 10002 | [#2] jquery.html Cycles:180 Average:27619.62 Median:2539.19 stddev:77916.69 (3068.6%) stddev-sans-first:78108.44 06:28:00 INFO - PROCESS | 10002 | Values: 387.7 391.0 394.4 396.4 408.9 17768.2 18298.8 18299.3 18306.9 18509.2 17857.0 18052.8 18429.8 18525.9 18939.2 5594.8 5773.5 5780.7 5788.1 5807.9 5628.4 5667.4 5699.1 5720.7 5783.5 5723.6 5724.8 5726.2 5731.2 5735.8 5558.9 5623.6 5698.8 5701.3 5714.7 5121.3 5127.6 5134.4 5138.5 5146.8 21255.1 22367.0 22501.0 22599.4 22633.3 2511.0 2567.3 2617.7 2712.2 3020.2 10002.0 13549.2 13601.6 14044.1 14166.0 1912.4 1957.6 1966.8 1969.9 1986.0 68264.0 70282.6 70442.6 70607.6 70908.6 10557.8 10690.3 10762.8 10835.3 10958.8 15404.8 15465.6 15485.0 15494.5 15521.8 8093.1 8171.4 8193.5 8229.3 8292.4 7986.9 8076.8 8127.1 8183.9 8202.6 4140.4 4348.5 4666.7 4746.4 4763.0 1849.5 1852.0 1908.2 1950.1 1955.0 918.2 931.7 992.8 1027.9 1053.2 17383.7 17771.2 17900.0 17994.6 18063.0 960.1 1004.3 1005.4 1018.7 1082.3 8678.8 10013.1 10043.4 10414.2 10491.2 461028.0 463284.0 470398.0 474281.0 503471.0 82234.0 83281.6 83534.0 83534.6 84286.0 1044.3 1049.7 1075.7 1142.2 1145.8 15913.2 16376.4 16408.2 16517.5 16668.0 35899.8 36980.8 37033.0 37339.4 38459.8 50593.7 50677.7 51224.2 51319.2 51600.2 8524.7 8672.6 8797.1 8875.7 8897.9 10185.9 13386.1 13579.6 13584.6 13586.8 11618.8 11681.8 11696.8 11899.3 12037.5 11775.5 11867.3 11884.0 11971.5 12055.9 10843.8 11961.8 12024.5 12181.9 12374.8 8674.1 8712.5 8752.3 8835.9 8883.4 10817.5 10849.0 10953.9 11013.7 11347.3 06:28:00 INFO - PROCESS | 10002 | 06:28:00 INFO - PROCESS | 10002 | [#3] mootools.html Cycles:180 Average:5956.62 Median:2978.91 stddev:3160.13 (106.1%) stddev-sans-first:3150.91 06:28:00 INFO - PROCESS | 10002 | Values: 1458.6 1578.0 1614.3 1750.7 1830.6 8268.5 8479.2 8495.3 8495.4 8497.4 8345.7 8516.5 8525.1 8525.7 8536.6 2406.1 2432.8 2438.0 2442.6 2444.3 2488.0 2496.9 2524.8 2536.0 2543.5 2450.7 2457.1 2457.3 2457.3 2458.1 2371.1 2379.7 2398.5 2464.0 2464.6 2466.1 2483.0 2503.0 2517.2 2520.2 8481.8 8538.6 8541.7 8599.1 8677.4 5196.7 5373.2 5411.6 5415.1 5422.0 3203.6 3226.5 3284.3 3336.7 3348.2 1060.3 1061.4 1068.6 1077.0 1080.4 11349.0 11556.9 11565.6 11566.8 11570.2 4506.8 4518.4 4603.0 4610.3 4637.2 9336.3 9379.1 9380.2 9388.7 9390.0 5216.9 5254.5 5265.3 5269.9 5297.8 4315.5 4728.4 4751.1 4807.8 4943.1 3613.5 3662.0 3681.6 3687.1 3736.0 1102.6 1112.0 1113.0 1115.2 1126.9 1273.4 1276.9 1343.7 1482.3 1512.3 8095.5 8260.4 8283.5 8289.8 8296.7 540.0 541.4 542.7 544.8 548.2 6156.6 6167.5 6178.8 6181.5 6237.5 10539.6 10566.4 10669.2 10748.1 10811.4 10277.5 10342.7 10376.9 10521.7 10528.2 8117.2 8276.1 8282.6 8303.3 8304.6 7883.1 7909.4 7920.9 8005.2 8081.0 9434.9 9473.5 9607.4 9674.5 9676.7 9671.8 9761.7 9883.8 9927.7 9946.0 6263.8 6823.6 7034.4 7071.2 7166.9 8180.2 8209.3 8225.9 8233.5 8255.3 7138.1 7295.4 7341.9 7424.4 7434.1 7104.8 7151.8 7155.6 7249.2 7325.6 7902.4 7906.8 8002.5 8014.5 8014.8 6743.3 7201.7 7252.7 7263.6 7263.6 7187.5 7243.9 7244.9 7251.5 7253.7 06:28:00 INFO - PROCESS | 10002 | 06:28:00 INFO - PROCESS | 10002 | [#4] prototype.html Cycles:180 Average:5349.12 Median:6132.13 stddev:1633.28 (26.6%) stddev-sans-first:1594.00 06:28:00 INFO - PROCESS | 10002 | Values: 339.5 339.9 345.1 345.2 355.5 6049.5 6050.8 6056.3 6107.5 6114.2 5935.8 5944.3 5945.5 5953.4 5963.8 4456.9 4510.8 4586.0 4635.0 4636.0 4605.8 4624.8 4630.0 4631.4 4661.1 4602.9 4609.1 4610.7 4616.5 4619.7 4448.6 4455.6 4530.6 4541.9 4555.9 3936.2 3946.4 3950.6 3952.1 3958.1 5702.8 5722.3 5733.8 5739.3 5742.2 5226.1 5247.3 5248.8 5257.5 5262.3 6293.6 6330.6 6335.8 6339.4 6340.1 4295.4 4375.2 4378.8 4428.1 4434.0 6604.2 6634.0 6634.9 6663.3 6676.9 4380.7 4387.4 4388.9 4396.6 4396.6 4449.9 4457.5 4458.1 4460.7 4462.3 5209.4 5210.5 5211.2 5217.5 5218.7 6333.5 6353.7 6407.3 6409.0 6410.9 1587.1 1603.4 1609.5 1609.8 1612.1 996.7 1021.0 1069.1 1111.5 1188.9 6150.1 6163.9 6169.0 6173.4 6191.2 6548.1 6556.6 6558.6 6560.0 6566.7 6180.1 6187.8 6194.3 6194.8 6196.6 3503.0 3549.9 3554.0 3554.1 3555.6 6773.4 6820.0 6900.1 6936.7 6954.3 6796.6 6806.1 6815.9 6817.4 6832.2 6892.9 6903.7 6930.4 6980.8 7009.0 6622.6 6646.6 6651.2 6652.2 6663.3 6437.9 6526.6 6553.6 6554.3 6563.3 6851.2 6899.9 6905.8 6921.6 6926.7 4619.4 4648.1 4662.3 4663.3 4665.0 6644.8 6649.8 6651.3 6657.4 6665.9 6330.2 6452.7 6466.2 6474.8 6478.1 6443.8 6481.2 6493.6 6495.9 6503.6 6318.8 6323.2 6327.1 6328.5 6333.2 6510.0 6510.1 6515.8 6524.0 6527.0 6031.1 6091.3 6332.8 6358.7 6373.4 06:28:00 INFO - PROCESS | 10002 | 06:28:00 INFO - PROCESS | 10002 | [#5] yui.html Cycles:180 Average:14546.97 Median:4373.43 stddev:16062.59 (367.3%) stddev-sans-first:16074.58 06:28:00 INFO - PROCESS | 10002 | Values: 823.0 856.5 857.6 909.9 949.4 15039.8 15260.0 15269.8 15282.8 15287.5 13971.5 14043.4 14092.9 14127.3 14653.0 927.9 934.6 938.6 944.8 945.2 951.9 951.9 952.4 952.5 952.6 993.9 996.2 996.8 996.8 997.2 987.4 989.4 989.6 990.4 994.3 726.6 730.3 730.4 731.0 731.2 14207.4 14234.2 14246.0 14296.0 14296.3 11639.3 11745.4 11914.5 12353.1 12427.9 10780.1 10916.1 10993.2 11012.8 11337.2 3907.3 3959.3 3980.2 3981.6 3987.6 46147.5 46586.3 51173.0 53264.5 53816.2 10397.0 11102.1 11598.6 11615.6 11760.6 16481.8 20336.0 20339.2 20379.3 20394.0 8365.5 8393.9 8437.5 8530.5 8533.4 4617.5 4722.7 4725.5 4770.1 4904.3 3402.4 3449.7 3454.2 3455.7 3456.7 655.4 655.6 660.2 676.8 689.3 592.8 669.4 674.3 707.5 770.0 9866.4 9931.0 10095.4 10131.3 10161.9 669.2 728.5 745.6 748.1 764.5 4345.5 4401.3 4495.1 4563.6 4614.6 57782.0 58359.4 60110.7 60138.0 60147.4 44470.6 50464.0 50612.2 50625.5 51404.0 46546.0 46831.5 47147.8 47675.3 47932.3 9535.8 9597.2 9766.6 9870.5 9875.8 34808.7 35067.8 35223.8 35765.1 36603.6 42257.4 42785.0 45556.3 46112.0 46780.3 12337.3 12380.2 12496.1 12509.7 12633.6 12597.9 13353.2 13690.0 13752.2 13825.4 12694.2 13032.0 13210.1 13555.2 13665.0 12958.2 13150.6 13309.3 13454.9 13961.7 12784.6 12928.9 13011.2 13037.1 13466.0 10515.4 10530.5 10877.5 10999.7 11058.5 10800.2 10859.0 10901.7 10905.3 11061.7 06:28:00 INFO - PROCESS | 10002 | -------- Summary: end -------- 06:28:00 INFO - PROCESS | 10002 | 06:28:01 INFO - TEST-INFO | 10002: exit 0 06:28:01 INFO - TEST-OK | dromaeo_css | took 1110357ms 06:28:01 INFO - TEST-START | kraken 06:28:01 INFO - operating with platform_type : linux_ 06:28:01 INFO - Initialising browser for kraken test... 06:28:01 INFO - TEST-INFO | started process 10206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0BACjZ/profile http://localhost:49516/getInfo.html) 06:28:05 INFO - PROCESS | 10206 | __metrics Screen width/height:1600/1200 06:28:05 INFO - PROCESS | 10206 | colorDepth:24 06:28:05 INFO - PROCESS | 10206 | Browser inner width/height: 1024/697 06:28:05 INFO - PROCESS | 10206 | __metrics 06:28:06 INFO - PROCESS | 10206 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:28:07 INFO - TEST-INFO | 10206: exit 0 06:28:07 INFO - Browser initialized. 06:28:07 INFO - Running cycle 1/1 for kraken test... 06:28:07 INFO - TEST-INFO | started process 10302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0BACjZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:18 INFO - PROCESS | 10302 | RSS: Main: 139382784 06:28:18 INFO - PROCESS | 10302 | 06:28:21 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49516/tests/kraken/driver.html?testName=audio-beat-detection) 06:28:21 INFO - PROCESS | 10302 | RSS: Main: 176279552 06:28:21 INFO - PROCESS | 10302 | 06:28:24 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49516/tests/kraken/driver.html?testName=audio-dft) 06:28:25 INFO - PROCESS | 10302 | RSS: Main: 175063040 06:28:25 INFO - PROCESS | 10302 | 06:28:28 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49516/tests/kraken/driver.html?testName=audio-fft) 06:28:28 INFO - PROCESS | 10302 | RSS: Main: 171425792 06:28:28 INFO - PROCESS | 10302 | 06:28:30 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49516/tests/kraken/driver.html?testName=audio-oscillator) 06:28:31 INFO - PROCESS | 10302 | RSS: Main: 171577344 06:28:31 INFO - PROCESS | 10302 | 06:28:33 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49516/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:28:34 INFO - PROCESS | 10302 | RSS: Main: 169619456 06:28:34 INFO - PROCESS | 10302 | 06:28:37 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49516/tests/kraken/driver.html?testName=imaging-darkroom) 06:28:37 INFO - PROCESS | 10302 | RSS: Main: 169193472 06:28:37 INFO - PROCESS | 10302 | 06:28:40 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49516/tests/kraken/driver.html?testName=imaging-desaturate) 06:28:41 INFO - PROCESS | 10302 | RSS: Main: 170012672 06:28:41 INFO - PROCESS | 10302 | 06:28:44 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49516/tests/kraken/driver.html?testName=json-parse-financial) 06:28:44 INFO - PROCESS | 10302 | RSS: Main: 169713664 06:28:44 INFO - PROCESS | 10302 | 06:28:46 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49516/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:28:47 INFO - PROCESS | 10302 | RSS: Main: 179023872 06:28:47 INFO - PROCESS | 10302 | 06:28:48 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49516/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:28:49 INFO - PROCESS | 10302 | RSS: Main: 177561600 06:28:49 INFO - PROCESS | 10302 | 06:28:51 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49516/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:28:52 INFO - PROCESS | 10302 | RSS: Main: 183648256 06:28:52 INFO - PROCESS | 10302 | 06:28:54 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:28:55 INFO - PROCESS | 10302 | RSS: Main: 187518976 06:28:55 INFO - PROCESS | 10302 | 06:28:57 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:28:58 INFO - PROCESS | 10302 | RSS: Main: 186843136 06:28:58 INFO - PROCESS | 10302 | 06:28:59 INFO - PROCESS | 10302 | Cycle 1(1): loaded http://localhost:49516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49516/tests/kraken/driver.html?testName=ai-astar) 06:29:00 INFO - PROCESS | 10302 | RSS: Main: 248397824 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | __start_tp_report 06:29:00 INFO - PROCESS | 10302 | _x_x_mozilla_page_load 06:29:00 INFO - PROCESS | 10302 | _x_x_mozilla_page_load_details 06:29:00 INFO - PROCESS | 10302 | |i|pagename|runs| 06:29:00 INFO - PROCESS | 10302 | |0;ai-astar;110;110;106;111;110;110;99;109;108;108 06:29:00 INFO - PROCESS | 10302 | |1;audio-beat-detection;153;138;161;166;127;152;155;134;176;128 06:29:00 INFO - PROCESS | 10302 | |2;audio-dft;160;162;161;160;162;161;162;163;160;162 06:29:00 INFO - PROCESS | 10302 | |3;audio-fft;76;77;74;163;76;76;75;75;166;77 06:29:00 INFO - PROCESS | 10302 | |4;audio-oscillator;93;94;149;93;94;94;147;93;94;137 06:29:00 INFO - PROCESS | 10302 | |5;imaging-gaussian-blur;116;117;117;117;116;118;116;117;117;117 06:29:00 INFO - PROCESS | 10302 | |6;imaging-darkroom;147;146;146;146;147;146;145;145;146;147 06:29:00 INFO - PROCESS | 10302 | |7;imaging-desaturate;96;96;96;95;95;95;96;95;97;95 06:29:00 INFO - PROCESS | 10302 | |8;json-parse-financial;56;57;58;56;55;57;57;58;65;54 06:29:00 INFO - PROCESS | 10302 | |9;json-stringify-tinderbox;65;66;65;64;64;67;65;66;67;66 06:29:00 INFO - PROCESS | 10302 | |10;stanford-crypto-aes;84;82;77;78;79;79;78;81;78;79 06:29:00 INFO - PROCESS | 10302 | |11;stanford-crypto-ccm;115;121;112;115;110;114;122;113;121;118 06:29:00 INFO - PROCESS | 10302 | |12;stanford-crypto-pbkdf2;138;138;145;146;144;139;144;145;144;154 06:29:00 INFO - PROCESS | 10302 | |13;stanford-crypto-sha256-iterative;68;66;72;68;68;67;67;66;64;65 06:29:00 INFO - PROCESS | 10302 | __end_tp_report 06:29:00 INFO - PROCESS | 10302 | __start_cc_report 06:29:00 INFO - PROCESS | 10302 | _x_x_mozilla_cycle_collect,1056 06:29:00 INFO - PROCESS | 10302 | __end_cc_report 06:29:00 INFO - PROCESS | 10302 | __startTimestamp1462800540011__endTimestamp 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | ------- Summary: start ------- 06:29:00 INFO - PROCESS | 10302 | Number of tests: 14 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.51 (3.2%) stddev-sans-first:3.66 06:29:00 INFO - PROCESS | 10302 | Values: 110.0 110.0 106.0 111.0 110.0 110.0 99.0 109.0 108.0 108.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.00 stddev:16.65 (10.8%) stddev-sans-first:17.59 06:29:00 INFO - PROCESS | 10302 | Values: 153.0 138.0 161.0 166.0 127.0 152.0 155.0 134.0 176.0 128.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 06:29:00 INFO - PROCESS | 10302 | Values: 160.0 162.0 161.0 160.0 162.0 161.0 162.0 163.0 160.0 162.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:37.44 (49.3%) stddev-sans-first:39.17 06:29:00 INFO - PROCESS | 10302 | Values: 76.0 77.0 74.0 163.0 76.0 76.0 75.0 75.0 166.0 77.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:93.50 stddev:24.71 (26.4%) stddev-sans-first:25.54 06:29:00 INFO - PROCESS | 10302 | Values: 93.0 94.0 149.0 93.0 94.0 94.0 147.0 93.0 94.0 137.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 06:29:00 INFO - PROCESS | 10302 | Values: 116.0 117.0 117.0 117.0 116.0 118.0 116.0 117.0 117.0 117.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 06:29:00 INFO - PROCESS | 10302 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 145.0 145.0 146.0 147.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 06:29:00 INFO - PROCESS | 10302 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 97.0 95.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.98 (5.2%) stddev-sans-first:3.13 06:29:00 INFO - PROCESS | 10302 | Values: 56.0 57.0 58.0 56.0 55.0 57.0 57.0 58.0 65.0 54.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 06:29:00 INFO - PROCESS | 10302 | Values: 65.0 66.0 65.0 64.0 64.0 67.0 65.0 66.0 67.0 66.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.17 (2.8%) stddev-sans-first:1.58 06:29:00 INFO - PROCESS | 10302 | Values: 84.0 82.0 77.0 78.0 79.0 79.0 78.0 81.0 78.0 79.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:116.50 stddev:4.18 (3.6%) stddev-sans-first:4.41 06:29:00 INFO - PROCESS | 10302 | Values: 115.0 121.0 112.0 115.0 110.0 114.0 122.0 113.0 121.0 118.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:144.50 stddev:4.74 (3.3%) stddev-sans-first:4.56 06:29:00 INFO - PROCESS | 10302 | Values: 138.0 138.0 145.0 146.0 144.0 139.0 144.0 145.0 144.0 154.0 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - PROCESS | 10302 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:2.18 (3.2%) stddev-sans-first:2.29 06:29:00 INFO - PROCESS | 10302 | Values: 68.0 66.0 72.0 68.0 68.0 67.0 67.0 66.0 64.0 65.0 06:29:00 INFO - PROCESS | 10302 | -------- Summary: end -------- 06:29:00 INFO - PROCESS | 10302 | 06:29:00 INFO - TEST-INFO | 10302: exit 0 06:29:00 INFO - TEST-OK | kraken | took 59605ms 06:29:00 INFO - SUITE-END | took 1169s 06:29:01 INFO - Completed test suite (00:19:30) 06:29:01 INFO - javascript benchmark 06:29:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3267.379197952389, 3321.319129578438, 3332.3668502984447, 3353.0779035765163, 3358.7313014958804, 5355.08963476209, 5360.169173778061, 5365.087935051046, 5370.597205209606, 5386.461353864612, 5362.597805164609, 5380.865478363043, 5392.352917649888, 5404.972975135119, 5422.1595652673805, 4762.261849413347, 4898.167311557035, 4915.238138088602, 4950.282209079682, 5027.4972502749615, 4922.926156107661, 4993.151164302078, 5023.748812559375, 5023.773930173151, 5025.246213068032, 4927.6550641455115, 4960.727160006199, 5060.493950604947, 5075.7715902784275, 5078.7460626968505, 5005.799768009275, 5013.799448022075, 5030.496950304977, 5032.974835125838, 5062.164742817449, 4754.7147171169845, 4830.782614782343, 4911.312416261726, 4924.60603151747, 4947.678400903966, 5213.947860521422, 5241.780366804721, 5242.397124330712, 5255.264263003182, 5284.022455845681, 5730.255066841326, 5759.769609215627, 5811.418858114197, 5814.447627475425, 5828.504577110951, 5797.913031304533, 5801.506871915893, 5804.187413762077, 5805.767769289223, 5817.680027598481, 5437.02133615949, 5438.211459338413, 5438.2386465894415, 5450.727463626803, 5479.260299859548, 5804.1293805929445, 5838.2702162229725, 5913.46778789911, 5943.078822782476, 5968.015277479168, 5625.0, 5649.830505084854, 5654.74553645087, 5662.915056274159, 5670.546356291569, 5752.050911599623, 5756.597038207286, 5762.337331206965, 5769.798057068067, 5774.393688662714, 5719.056355701346, 5790.276215473066, 5850.736716847667, 5874.148248503943, 5894.498967587718, 5819.214406055213, 5830.5044071254415, 5839.445252700986, 5844.59087863854, 5853.88292234153, 4346.326319420495, 4453.487848897418, 4457.977710111429, 4458.4426946631675, 4496.910061798746, 3941.3890846918775, 3982.820773065219, 3996.6403023728003, 3997.400389941532, 4023.979880100639, 5475.945240547623, 5476.0, 5478.58910581708, 5479.3424789024775, 5484.095124304445, 5728.79949201776, 5771.88456230873, 5807.680577568274, 5807.88384232313, 5824.213731146326, 5557.72211389437, 5563.221149039137, 5586.24585680936, 5596.188552659923, 5625.915611265835, 5065.214891691794, 5065.898682026339, 5066.240063990357, 5067.366579177603, 5087.0, 5869.0, 5988.850278743066, 6079.08813677943, 6096.756129754849, 6116.052011938156, 5864.618799778001, 5871.089981052858, 5872.647641141545, 5877.118432235199, 5877.73550190251, 6056.788012419544, 6069.089636554552, 6071.696415179135, 6081.361457047124, 6085.817425477243, 5658.236138121466, 5726.226959360433, 5776.393478684846, 5794.0, 5822.796202132905, 5820.94179058204, 5823.126531020381, 5835.212246346859, 5839.211706419579, 5840.474357307863, 5688.061469857427, 5689.6586204827845, 5691.174779657009, 5695.601307908407, 5696.0, 5537.861553461195, 5647.88704225905, 5724.4561766632105, 5755.8561035974435, 5788.450097240755, 5538.889222215453, 5570.303712035996, 5571.526420254324, 5571.60998730085, 5584.357798853184, 5619.522340601095, 5655.208270842003, 5699.943000569941, 5709.0, 5714.3714191438075, 5547.084731019498, 5582.190582365615, 5603.35561410443, 5683.943160568341, 5726.627769194989], "unit": "score", "name": "dojo.html", "value": 5367.391940473573}, {"lowerIsBetter": false, "replicates": [565.1494500776331, 565.3187908570172, 578.4909279833745, 580.4137820800993, 590.4154886662205, 34850.82574587127, 35697.82151089247, 39321.803390983005, 39933.600663993355, 40042.39936400949, 42909.0, 43449.78275108628, 43455.78272108643, 43576.12847743043, 43628.0, 8858.557072146383, 9065.18413342799, 9065.22945549629, 9065.546722663874, 9068.229200517964, 8904.465732056065, 9023.233025192834, 9032.954835225815, 9036.954815225947, 9045.276377889753, 9267.25861931044, 9329.67346142885, 9359.625614975394, 9362.531873406337, 9364.953175234114, 9163.129502697266, 9215.539223038888, 9238.58426370815, 9240.445573265592, 9241.122093401116, 9147.359684822066, 9269.397489163182, 9279.67521136757, 9283.953580232122, 9286.396384235004, 43366.783166084286, 43650.12699746019, 43692.781536092116, 43706.0, 43776.56223437757, 3657.6708096271195, 3839.520059992501, 3920.647141757227, 4099.938500922489, 4267.63182229467, 33160.834195829106, 33501.0, 33568.3286334272, 34051.14872128192, 34152.48771268433, 4192.769397683126, 4289.592488713567, 4298.763568003758, 4305.5048669402795, 4347.3261644445165, 297606.0, 299744.0, 299788.99999999785, 300557.0, 300944.0, 46284.7685761569, 66690.0, 66890.66554667195, 66899.33100668932, 66942.33057669459, 44885.551144488134, 44901.55098448974, 44934.77532612316, 44979.77510112494, 45123.54876451259, 16093.195340232942, 16391.180440977903, 16408.67182656364, 16416.261268242957, 16448.34206631745, 12797.936010319889, 12900.419481123372, 12900.548480803314, 12904.290264035568, 12912.483500659868, 15569.766453503207, 15661.84338156604, 15995.600109997344, 15999.200039997953, 16044.598885027734, 6016.639001659914, 6069.757209711562, 6148.569600127948, 6164.815055548341, 6232.56372053961, 1096.2983690438125, 1104.9337039777638, 1150.5560521545408, 1159.860816702001, 1224.5897624295783, 30683.539746903814, 30930.381392372477, 30981.8450907744, 31074.68925310718, 31346.373072538423, 1082.3397727386289, 1166.1603645375317, 1183.3964678014274, 1240.8635050144476, 1285.4344088601172, 16150.59623509398, 16196.352145914267, 16554.503364899072, 16610.83389166093, 16756.0, 335454.0, 512323.0, 517953.0, 520458.0, 520800.0, 56613.0, 57060.0, 57282.0, 57350.42649573451, 57431.0, 1418.899057886895, 1487.7693957436616, 1489.3372449259975, 1499.3253036133783, 1502.774583812437, 31399.0, 32859.04779979128, 32941.341173175926, 33039.50440743439, 33323.83338083391, 46741.0, 47186.764066180825, 47412.288815668486, 47466.28800568063, 47475.0, 238306.0, 239337.0, 248701.0, 249292.0, 249788.0, 31023.224419389695, 33071.66928330686, 51082.74458627683, 51538.22692659538, 55133.448665512835, 47951.5204847961, 48207.75896120497, 48786.0, 48901.2664810021, 49381.506184937694, 39347.4260134295, 39948.0, 40140.59859401369, 40140.99647508836, 42335.0, 41614.58385416107, 41798.37302440405, 42060.36909446299, 42171.57828421677, 43191.78404107959, 41977.1604567913, 42403.1519369617, 42889.78555107329, 43316.13367732565, 43503.347449787645, 37674.81162594169, 37747.81126094352, 37822.62177378301, 37849.24301514009, 38133.0, 28471.145865624065, 29109.85445072761, 29182.56226156652, 29326.26684332909, 29434.0], "unit": "score", "name": "ext.html", "value": 19820.229998623112}, {"lowerIsBetter": false, "replicates": [387.7460263527387, 390.980450977451, 394.4379259555133, 396.4212250114832, 408.87120557024537, 17768.20043098062, 18298.817011829895, 18299.268029278828, 18306.908465457655, 18509.167087481062, 17857.0, 18052.819471805276, 18429.815701842977, 18525.90737046313, 18939.242430302773, 5594.804181853636, 5773.451522105393, 5780.682062486561, 5788.131780232957, 5807.9419205808035, 5628.352739434956, 5667.4049224831415, 5699.059655156894, 5720.713964301789, 5783.479486846183, 5723.599348045638, 5724.8282551523525, 5726.226959360495, 5731.226284451587, 5735.827925162231, 5558.888822223574, 5623.550115990732, 5698.772049118031, 5701.315842098933, 5714.7428365723645, 5121.308623335839, 5127.641065125443, 5134.358205224347, 5138.486151384869, 5146.768395422215, 21255.149794008223, 22367.0, 22501.0, 22599.435014124614, 22633.321000370015, 2511.0332521978985, 2567.3453269416177, 2617.6727909011374, 2712.213458097169, 3020.1845501714415, 10002.0, 13549.187048777105, 13601.591952241448, 14044.087134336236, 14166.0, 1912.3593596145308, 1957.5889063296725, 1966.8131527505006, 1969.9310524131586, 1985.960280794376, 68264.0, 70282.64858675725, 70442.64778676073, 70607.64696176538, 70908.64545677238, 10557.841632375521, 10690.251682382159, 10762.78474430507, 10835.295705779099, 10958.835617465744, 15404.845951540341, 15465.613359666098, 15484.986951696208, 15494.5351639451, 15521.767173492406, 8093.109757926623, 8171.387145963958, 8193.50838949665, 8229.341652667772, 8292.419530632798, 7986.880196797053, 8076.798080048045, 8127.065387480516, 8183.877241841377, 8202.630881610341, 4140.44104045956, 4348.5216626171095, 4666.673332866667, 4746.359241502353, 4762.976185119052, 1849.546861019059, 1851.981480185181, 1908.1508728615634, 1950.141937547503, 1954.9706754398696, 918.2332752152028, 931.7344556801414, 992.8312186928096, 1027.8715160604925, 1053.1995683280609, 17383.73924391135, 17771.222877712386, 17900.0, 17994.64010719778, 18063.0, 960.1214888377057, 1004.317064396203, 1005.4369553050316, 1018.7453136715822, 1082.2694681090234, 8678.826423471495, 10013.148882344936, 10043.397396156253, 10414.16686665065, 10491.213159013105, 461028.0, 463284.0, 470398.0, 474281.0, 503471.0, 82234.0, 83281.58359208165, 83534.0, 83534.58232708798, 84286.0, 1044.2951008069674, 1049.7119267791006, 1075.6772968109692, 1142.2175809570472, 1145.777192247038, 15913.204339783197, 16376.426825061066, 16408.17959102064, 16517.504474865775, 16668.0, 35899.82050089733, 36980.81509592435, 37033.0, 37339.439908400855, 38459.80770096132, 50593.74703126608, 50677.74661126671, 51224.23163652474, 51319.230211547605, 51600.22599661083, 8524.70163544273, 8672.609732562176, 8797.12028797115, 8875.689350872946, 8897.911020889967, 10185.898141018792, 13386.062975592005, 13579.59261222165, 13584.592462226148, 13586.796198057235, 11618.76762464763, 11681.824772628588, 11696.766064678828, 11899.345535995257, 12037.45831437605, 11775.470103845177, 11867.347295898808, 11884.0, 11971.461284242056, 12055.939720301343, 10843.783124337628, 11961.820572691242, 12024.519019239482, 12181.878181218075, 12374.752504950031, 8674.132586741527, 8712.477251364939, 8752.256058235122, 8835.911640883509, 8883.37816352849, 10817.459127043774, 10849.0, 10953.890461095605, 11013.704903995875, 11347.319160850046], "unit": "score", "name": "jquery.html", "value": 9088.220489912925}, {"lowerIsBetter": false, "replicates": [1458.6134674311315, 1578.0373971877152, 1614.2655091933173, 1750.7023805952986, 1830.5972686009081, 8268.545230012347, 8479.152084791518, 8495.32037437005, 8495.405321627488, 8497.362697797675, 8345.707900223493, 8516.489010659365, 8525.062243153263, 8525.701600443987, 8536.615852286646, 2406.061635961976, 2432.8297019208662, 2437.9634305485433, 2442.5725498037773, 2444.2667199840066, 2487.9751202488014, 2496.8876400562017, 2524.835885667426, 2536.0, 2543.4785868896925, 2450.742672019439, 2457.054034196838, 2457.287386657867, 2457.336519139831, 2458.1027924807495, 2371.1463873005705, 2379.690640216778, 2398.5442765874513, 2463.9507209855883, 2464.5933420985693, 2466.13685210175, 2483.0316176691103, 2502.987485062581, 2517.1567524879188, 2520.231329444519, 8481.830363392697, 8538.573071346469, 8541.701040463617, 8599.097094805018, 8677.392582519225, 5196.740162991835, 5373.194020896858, 5411.56707463402, 5415.10650742627, 5421.972890135524, 3203.6475987641575, 3226.548283240348, 3284.310294838087, 3336.7497437692027, 3348.2466445049913, 1060.2790102730141, 1061.4109169410974, 1068.6206396729126, 1076.9951834382064, 1080.443571560647, 11349.0, 11556.88443115575, 11565.595204167897, 11566.768664626745, 11570.247933884186, 4506.774661266923, 4518.367428560005, 4603.0, 4610.308453731967, 4637.211674015425, 9336.346455748168, 9379.062093790566, 9380.155785979157, 9388.67139650109, 9389.953050234704, 5216.895662086813, 5254.500822421864, 5265.315508983884, 5269.920951185735, 5297.8145764898045, 4315.4605674290715, 4728.432588089451, 4751.09729151467, 4807.831725889577, 4943.085529177042, 3613.4760459733193, 3661.9633803662155, 3681.5582130144553, 3687.0966613179944, 3736.0286325555007, 1102.6030628973563, 1111.9777604447866, 1112.9944350278358, 1115.2026301194685, 1126.8929451702074, 1273.38877338876, 1276.8786965238287, 1343.7043850352907, 1482.2959094430275, 1512.296781996377, 8095.473794203358, 8260.421770476009, 8283.544405057659, 8289.8342033159, 8296.70961516344, 540.0441219042273, 541.4071591607262, 542.7204989430446, 544.7793643574358, 548.2434240747742, 6156.630602163885, 6167.537434692416, 6178.814635560941, 6181.474574661114, 6237.4698150656795, 10539.63111291101, 10566.366018038789, 10669.19981001428, 10748.140148788078, 10811.35131892089, 10277.537510812032, 10342.689719308433, 10376.948115259376, 10521.736956576147, 10528.210384221215, 8117.228863257981, 8276.08963014068, 8282.585870706562, 8303.335733141334, 8304.584770761438, 7883.093444253984, 7909.446338756232, 7920.881186782318, 8005.239502247277, 8081.0, 9434.905650943678, 9473.526323683926, 9607.423554586747, 9674.467904265333, 9676.709698708768, 9671.806563868824, 9761.707148785548, 9883.752906177404, 9927.702168934944, 9945.950270248602, 6263.812085637438, 6823.590584564942, 7034.402075823612, 7071.186813516511, 7166.8924966124505, 8180.181981801772, 8209.302209312036, 8225.876611850947, 8233.50598964064, 8255.298299644597, 7138.143422789299, 7295.379892709179, 7341.926580734124, 7424.36892864091, 7434.107907051189, 7104.822379440556, 7151.7854464366155, 7155.606441645551, 7249.166345870292, 7325.560466372035, 7902.407319451179, 7906.841863162819, 8002.51984880909, 8014.519128852287, 8014.799630009296, 6743.325667433218, 7201.675924583302, 7252.673629686571, 7263.564186148848, 7263.564186148848, 7187.532810367518, 7243.927560724325, 7244.927550724636, 7251.5286506376915, 7253.746118885813], "unit": "score", "name": "mootools.html", "value": 4776.21538708001}, {"lowerIsBetter": false, "replicates": [339.5212750022468, 339.86575302755415, 345.0769192410303, 345.18536254439533, 355.46679980029955, 6049.455549000594, 6050.757969681213, 6056.3338032816355, 6107.511399088074, 6114.1745864308305, 5935.762569497215, 5944.286685597724, 5945.524358051356, 5953.434423729749, 5963.821085367446, 4456.866294011169, 4510.751908645023, 4586.0, 4634.980304333041, 4635.976820115895, 4605.769711514427, 4624.8150073997, 4630.0, 4631.421072365954, 4661.137689527432, 4602.930956035662, 4609.055143695535, 4610.700304480215, 4616.469106052813, 4619.653525985547, 4448.644108471331, 4455.621272191867, 4530.637548996106, 4541.931871021938, 4555.863324100283, 3936.153726948691, 3946.4080387941754, 3950.644442000234, 3952.110775075585, 3958.050067983692, 5702.800401985911, 5722.256106706143, 5733.799317023884, 5739.282589676291, 5742.196092547047, 5226.137687281632, 5247.317848679647, 5248.816291429782, 5257.526822585947, 5262.2632831403635, 6293.590916590407, 6330.588511746721, 6335.8416039598915, 6339.429451349354, 6340.112384266206, 4295.4201182840225, 4375.234333991539, 4378.817719215794, 4428.114377124556, 4434.0, 6604.2405123410945, 6634.038064480672, 6634.933650663528, 6663.267040625576, 6676.93323066768, 4380.685794261773, 4387.3857659927635, 4388.868333949987, 4396.560343965578, 4396.626286765661, 4449.86650400482, 4457.465104187453, 4458.08609235106, 4460.665450091256, 4462.3083422068985, 5209.4009188943755, 5210.452902445264, 5211.244369566468, 5217.452167522431, 5218.739063046833, 6333.524985626004, 6353.7140828661895, 6407.295197528269, 6408.967955160194, 6410.8717825643225, 1587.0715631355556, 1603.3666701652783, 1609.49300970194, 1609.8390160983809, 1612.1455628516906, 996.7458298133929, 1020.9846852297221, 1069.096613361708, 1111.5053801058452, 1188.922720023213, 6150.07748837669, 6163.876722465526, 6169.043798211284, 6173.41352571505, 6191.226096737908, 6548.083268342436, 6556.63938483388, 6558.639274839929, 6559.967200163968, 6566.737330506822, 6180.134781130645, 6187.752489900444, 6194.287656919422, 6194.752209911553, 6196.597221180699, 3503.0, 3549.893503194908, 3553.9822300888845, 3554.129238336624, 3555.5555555555557, 6773.390394864486, 6819.965900170567, 6900.137482814648, 6936.687849046805, 6954.3045695431065, 6796.592204467748, 6806.149231346082, 6815.863682726318, 6817.420519255918, 6832.248452670202, 6892.862142757117, 6903.6548172591165, 6930.3762661360715, 6980.7905762827195, 7008.999999999898, 6622.602643841385, 6646.634435106115, 6651.235107962452, 6652.168478940132, 6663.333666633298, 6437.935620643921, 6526.608403495806, 6553.606783593, 6554.31179726141, 6563.278039415565, 6851.2121106071445, 6899.862002760017, 6905.758298459731, 6921.6193109379465, 6926.653667316513, 4619.422572178478, 4648.093621743727, 4662.277347011219, 4663.253879379418, 4665.043666048384, 6644.800655980328, 6649.800505984828, 6651.301613330531, 6657.40083392497, 6665.900011499734, 6330.208723909512, 6452.741890324334, 6466.159399278064, 6474.838129046623, 6478.060681201294, 6443.838904027437, 6481.157449531531, 6493.610383377012, 6495.870082598416, 6503.577267477788, 6318.842028949313, 6323.241211054703, 6327.082573026793, 6328.525360597881, 6333.1766870306565, 6510.0, 6510.121133646897, 6515.837104072436, 6524.0, 6527.0, 6031.09533569968, 6091.329953705177, 6332.841678957879, 6358.650274234961, 6373.426391624776], "unit": "score", "name": "prototype.html", "value": 4819.9544405442575}, {"lowerIsBetter": false, "replicates": [822.9547374894386, 856.5075081827947, 857.6397912876591, 909.8544232922734, 949.3734135470587, 15039.849601503982, 15260.0, 15269.847301526981, 15282.847171528281, 15287.464938727147, 13971.510997115103, 14043.438262469488, 14092.859071409282, 14127.293635318245, 14653.0, 927.9443233405983, 934.56075644447, 938.6010945348199, 944.8204841080172, 945.1871390604075, 951.8619800128977, 951.8619800128977, 952.3714348529971, 952.4570994533084, 952.5570609666504, 993.9055789699967, 996.1930836022808, 996.7508122969258, 996.8305388084043, 997.2122023601382, 987.3976874106789, 989.366805244644, 989.6189966862773, 990.4107056301525, 994.2791476179748, 726.6403130450461, 730.2952650692055, 730.3974221267475, 731.042334541752, 731.2249016043012, 14207.36066876993, 14234.217118058503, 14246.0, 14296.0, 14296.285185740671, 11639.301641901428, 11745.354005529693, 11914.46384912681, 12353.073519485984, 12427.93786031064, 10780.137588992862, 10916.07213386863, 10993.175511836564, 11012.834807477895, 11337.206395552315, 3907.27715372657, 3959.3467077932105, 3980.1641655252433, 3981.5620281768984, 3987.581303963071, 46147.53852461466, 46586.30120548195, 51173.0, 53264.467355326335, 53816.192757109064, 10397.012283833024, 11102.056325212287, 11598.594049208237, 11615.59345422923, 11760.647180584596, 16481.83518164803, 20336.0, 20339.186432542534, 20379.286724964553, 20394.0, 8365.498070115813, 8393.874091888627, 8437.493750374875, 8530.488170709777, 8533.402661813614, 4617.5382461754225, 4722.669413141116, 4725.480197178307, 4770.117528257283, 4904.337914381585, 3402.4385976314124, 3449.741269404805, 3454.1537323355938, 3455.6544345565244, 3456.70617997468, 655.3577494055852, 655.6262930129781, 660.2275337854721, 676.8409423785406, 689.3141324382171, 592.7895597063067, 669.4142625202948, 674.3290426026135, 707.4517249131861, 770.0374531835206, 9866.408015519091, 9931.0, 10095.394276343295, 10131.341462805041, 10161.949190254001, 669.1668872254074, 728.4682182007165, 745.5899255409612, 748.1134855196609, 764.4763337114094, 4345.521992580813, 4401.339799030107, 4495.100979804052, 4563.612092972135, 4614.607758340579, 57782.0, 58359.4164058354, 60110.69944650249, 60138.0, 60147.39852601506, 44470.55529444729, 50464.0, 50612.240816387784, 50625.49374506281, 51404.0, 46546.0, 46831.531684683396, 47147.764261178476, 47675.284870726966, 47932.28101578549, 9535.76160595963, 9597.184239339735, 9766.560504777444, 9870.457124858201, 9875.753106172404, 34808.65191348054, 35067.82466087653, 35223.82388088043, 35765.1058723534, 36603.63396366109, 42257.366139508544, 42785.0, 45556.31665525086, 46112.0, 46780.29829552492, 12337.321447320484, 12380.195287306296, 12496.125271230927, 12509.74980500403, 12633.620991370273, 12597.93701031489, 13353.198808071547, 13690.0, 13752.243626600633, 13825.377857996615, 12694.174878632859, 13032.0, 13210.141340812816, 13555.186688798703, 13665.0, 12958.157719748186, 13150.60548183556, 13309.334533273104, 13454.932725336703, 13961.720765584834, 12784.616461505797, 12928.870711293142, 13011.154274972096, 13037.087403881636, 13466.0, 10515.421651808918, 10530.526126324181, 10877.456127193767, 10999.670009899715, 11058.502367393326, 10800.24398292112, 10859.0, 10901.672949811518, 10905.291156074829, 11061.723456913642], "unit": "score", "name": "yui.html", "value": 6951.539157276428}], "name": "dromaeo_css", "value": 7327.112447096609}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 111.0, 110.0, 110.0, 99.0, 109.0, 108.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [153.0, 138.0, 161.0, 166.0, 127.0, 152.0, 155.0, 134.0, 176.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 160.0, 162.0, 161.0, 162.0, 163.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 74.0, 163.0, 76.0, 76.0, 75.0, 75.0, 166.0, 77.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 149.0, 93.0, 94.0, 94.0, 147.0, 93.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 56.0, 55.0, 57.0, 57.0, 58.0, 65.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 64.0, 64.0, 67.0, 65.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.5}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 77.0, 78.0, 79.0, 79.0, 78.0, 81.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.5}, {"lowerIsBetter": true, "replicates": [115.0, 121.0, 112.0, 115.0, 110.0, 114.0, 122.0, 113.0, 121.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.1}, {"lowerIsBetter": true, "replicates": [138.0, 138.0, 145.0, 146.0, 144.0, 139.0, 144.0, 145.0, 144.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 72.0, 68.0, 68.0, 67.0, 67.0, 66.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1508.3999999999999}]} 06:29:01 INFO - Return code: 0 06:29:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:29:01 INFO - # TBPL SUCCESS # 06:29:01 INFO - Running post-action listener: _resource_record_post_action 06:29:01 INFO - Running post-run listener: _resource_record_post_run 06:29:02 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 459890688; Read time: 0; Write time: 302180 06:29:02 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237568000; Read time: 0; Write time: 206332 06:29:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 222322688; Read time: 0; Write time: 95848 06:29:02 INFO - Running post-run listener: _upload_blobber_files 06:29:02 INFO - Blob upload gear active. 06:29:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:29:02 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 06:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:29:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:03 INFO - (blobuploader) - INFO - Done attempting. 06:29:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:29:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:29:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:04 INFO - (blobuploader) - INFO - Done attempting. 06:29:04 INFO - (blobuploader) - INFO - Iteration through files over. 06:29:04 INFO - Return code: 0 06:29:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:29:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:29:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c454465685a61f234d0cbe509c8a221c39576d916f6ecd7330d9ec79695826f7be6c25c495c982062da4880e802b9345a33cf6761f398ea7b57cb3d6d807f37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba862eebbf5e26629894b24dc38357524c252b3ee9039d0dd44caba9a89f9b0c71c473b933d8ba5603fd81ad10905ce6d26885f4927f8be7797bf788e1a568f2"} 06:29:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:29:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:29:04 INFO - Contents: 06:29:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c454465685a61f234d0cbe509c8a221c39576d916f6ecd7330d9ec79695826f7be6c25c495c982062da4880e802b9345a33cf6761f398ea7b57cb3d6d807f37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba862eebbf5e26629894b24dc38357524c252b3ee9039d0dd44caba9a89f9b0c71c473b933d8ba5603fd81ad10905ce6d26885f4927f8be7797bf788e1a568f2"} 06:29:04 INFO - Running post-run listener: copy_logs_to_upload_dir 06:29:04 INFO - Copying logs to upload dir... 06:29:04 INFO - mkdir: /builds/slave/test/build/upload/logs 06:29:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.512276 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-05-09 06:29:03.748265) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:29:03.751901) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c454465685a61f234d0cbe509c8a221c39576d916f6ecd7330d9ec79695826f7be6c25c495c982062da4880e802b9345a33cf6761f398ea7b57cb3d6d807f37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba862eebbf5e26629894b24dc38357524c252b3ee9039d0dd44caba9a89f9b0c71c473b933d8ba5603fd81ad10905ce6d26885f4927f8be7797bf788e1a568f2"} build_url:https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/BKeArZvATEebusIe36rW3Q/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c454465685a61f234d0cbe509c8a221c39576d916f6ecd7330d9ec79695826f7be6c25c495c982062da4880e802b9345a33cf6761f398ea7b57cb3d6d807f37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba862eebbf5e26629894b24dc38357524c252b3ee9039d0dd44caba9a89f9b0c71c473b933d8ba5603fd81ad10905ce6d26885f4927f8be7797bf788e1a568f2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:29:03.776308) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:29:03.776663) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462799319.990814-2024174220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:29:03.859127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:29:03.859422) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:29:03.859736) ========= ========= Total master_lag: 0.16 =========