builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1481038872.79 results: success (0) buildid: 20161206055938 builduid: 819d402fe0b645bc8a0d487346a45582 revision: 48a4769a75a5d459dd86c4a1a2f9babb75c9eede ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:12.791111) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:12.791607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:12.791901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:12.812019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:12.812409) ========= 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=d2a8c569965ab8367867b893000001a1-1481020656.893036-420408684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-06 07:41:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 209M=0s 2016-12-06 07:41:15 (209 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074233 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:12.904069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:12.904392) ========= 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=d2a8c569965ab8367867b893000001a1-1481020656.893036-420408684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016021 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:12.956701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:12.957061) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 48a4769a75a5d459dd86c4a1a2f9babb75c9eede --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 48a4769a75a5d459dd86c4a1a2f9babb75c9eede --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=d2a8c569965ab8367867b893000001a1-1481020656.893036-420408684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-06 07:41:15,410 truncating revision to first 12 chars 2016-12-06 07:41:15,411 Setting DEBUG logging. 2016-12-06 07:41:15,411 attempt 1/10 2016-12-06 07:41:15,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/48a4769a75a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-06 07:41:15,725 unpacking tar archive at: mozilla-aurora-48a4769a75a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:13.614220) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:13.614715) ========= script_repo_revision: 48a4769a75a5d459dd86c4a1a2f9babb75c9eede ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:13.615347) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:13.615774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-06 07:41:13.682451) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-06 07:41:13.682758) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1481020656.893036-420408684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:41:16 INFO - MultiFileLogger online at 20161206 07:41:16 in /builds/slave/test 07:41:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:41:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:41:16 INFO - {'append_to_log': False, 07:41:16 INFO - 'base_work_dir': '/builds/slave/test', 07:41:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:41:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:41:16 INFO - 'branch': 'Mozilla-Aurora', 07:41:16 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:16 INFO - 'config_files': ('talos/linux_config.py',), 07:41:16 INFO - 'default_actions': ('clobber', 07:41:16 INFO - 'read-buildbot-config', 07:41:16 INFO - 'download-and-extract', 07:41:16 INFO - 'populate-webroot', 07:41:16 INFO - 'create-virtualenv', 07:41:16 INFO - 'install', 07:41:16 INFO - 'run-tests'), 07:41:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:16 INFO - 'download_minidump_stackwalk': True, 07:41:16 INFO - 'download_symbols': 'ondemand', 07:41:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:16 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:16 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:16 INFO - 'installer_path': 'installer.exe', 07:41:16 INFO - 'log_level': 'info', 07:41:16 INFO - 'log_name': 'talos', 07:41:16 INFO - 'log_to_console': True, 07:41:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:41:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:41:16 INFO - 'opt_config_files': (), 07:41:16 INFO - 'pip_index': False, 07:41:16 INFO - 'sps_profile': False, 07:41:16 INFO - 'sps_profile_interval': 0, 07:41:16 INFO - 'suite': 'dromaeojs', 07:41:16 INFO - 'system_bits': '32', 07:41:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:16 INFO - 'title': 'talos-linux64-ix-043', 07:41:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:16 INFO - 'use_talos_json': True, 07:41:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:41:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:16 INFO - 'work_dir': 'build'} 07:41:16 INFO - [mozharness: 2016-12-06 15:41:16.233289Z] Running clobber step. 07:41:16 INFO - Running pre-action listener: _resource_record_pre_action 07:41:16 INFO - Running main action method: clobber 07:41:16 INFO - rmtree: /builds/slave/test/build 07:41:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:41:17 INFO - Running post-action listener: _resource_record_post_action 07:41:17 INFO - [mozharness: 2016-12-06 15:41:17.223335Z] Finished clobber step (success) 07:41:17 INFO - [mozharness: 2016-12-06 15:41:17.223434Z] Running read-buildbot-config step. 07:41:17 INFO - Running pre-action listener: _resource_record_pre_action 07:41:17 INFO - Running main action method: read_buildbot_config 07:41:17 INFO - Using buildbot properties: 07:41:17 INFO - { 07:41:17 INFO - "project": "", 07:41:17 INFO - "product": "firefox", 07:41:17 INFO - "script_repo_revision": "production", 07:41:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:41:17 INFO - "repository": "", 07:41:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:41:17 INFO - "buildid": "20161206055938", 07:41:17 INFO - "pgo_build": "True", 07:41:17 INFO - "basedir": "/builds/slave/test", 07:41:17 INFO - "buildnumber": 660, 07:41:17 INFO - "slavename": "talos-linux64-ix-043", 07:41:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:41:17 INFO - "platform": "ubuntu64_hw", 07:41:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:41:17 INFO - "branch": "mozilla-aurora", 07:41:17 INFO - "repo_path": "releases/mozilla-aurora", 07:41:17 INFO - "revision": "48a4769a75a5d459dd86c4a1a2f9babb75c9eede", 07:41:17 INFO - "stage_platform": "linux64-pgo", 07:41:17 INFO - "builduid": "819d402fe0b645bc8a0d487346a45582", 07:41:17 INFO - "slavebuilddir": "test" 07:41:17 INFO - } 07:41:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 07:41:17 INFO - Running post-action listener: _resource_record_post_action 07:41:17 INFO - [mozharness: 2016-12-06 15:41:17.226527Z] Finished read-buildbot-config step (success) 07:41:17 INFO - [mozharness: 2016-12-06 15:41:17.226615Z] Running download-and-extract step. 07:41:17 INFO - Running pre-action listener: _resource_record_pre_action 07:41:17 INFO - Running main action method: download_and_extract 07:41:17 INFO - mkdir: /builds/slave/test/build/tests 07:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:17 INFO - trying https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:41:17 INFO - Downloading https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:41:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:41:17 INFO - Downloaded 1361 bytes. 07:41:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:41:17 INFO - Using the following test package requirements: 07:41:17 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:41:17 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:41:17 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:41:17 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:17 INFO - u'jsshell-linux-x86_64.zip'], 07:41:17 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:41:17 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:41:17 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:41:17 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:41:17 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:41:17 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:41:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:41:17 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:41:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:41:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:41:17 INFO - Fetch https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:41:18 INFO - Http code: 200 07:41:18 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 07:41:18 INFO - x-amz-cf-id: yqEi5rJlc59B-6CBIfRNmCPXZb9q931FD-e1pA4xWy-21l3tll_8oA== 07:41:18 INFO - x-amz-version-id: su9aoCyBjg3XsfaHNqqEw4MLmYIlHz30 07:41:18 INFO - Expected file size: 21954481 07:41:18 INFO - Obtained file size: 21954481 07:41:22 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:41:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:41:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:41:22 INFO - Fetch https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:41:23 INFO - Http code: 200 07:41:23 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 07:41:23 INFO - x-amz-cf-id: ls-MiJSHkmI8RudIe4qKbQBOb8EneXNQA4orMypelWGsQiwJKIZIzw== 07:41:23 INFO - x-amz-version-id: su9aoCyBjg3XsfaHNqqEw4MLmYIlHz30 07:41:23 INFO - Expected file size: 21954481 07:41:23 INFO - Obtained file size: 21954481 07:41:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 07:41:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:41:28 INFO - Fetch https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:41:28 INFO - Http code: 200 07:41:28 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 07:41:28 INFO - x-amz-cf-id: F34jEffhVxWFL5h9tHdb2LEQSTFGepfqs9kL7eWd7wVirmsJ4biKXQ== 07:41:28 INFO - x-amz-version-id: GV75Q3yhfcbXeTx4jlbnl1P8917hiG7H 07:41:28 INFO - Expected file size: 14409038 07:41:28 INFO - Obtained file size: 14409038 07:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:29 INFO - trying https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:41:29 INFO - Downloading https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:41:30 INFO - Downloaded 64020941 bytes. 07:41:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:41:30 INFO - mkdir: /builds/slave/test/properties 07:41:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:30 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:30 INFO - Contents: 07:41:30 INFO - build_url:https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:41:31 INFO - Running post-action listener: _resource_record_post_action 07:41:31 INFO - Running post-action listener: set_extra_try_arguments 07:41:31 INFO - [mozharness: 2016-12-06 15:41:31.419450Z] Finished download-and-extract step (success) 07:41:31 INFO - [mozharness: 2016-12-06 15:41:31.419677Z] Running populate-webroot step. 07:41:31 INFO - Running pre-action listener: _resource_record_pre_action 07:41:31 INFO - Running main action method: populate_webroot 07:41:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:31 INFO - '--tppagecycles', 07:41:31 INFO - '7'], 07:41:31 INFO - 'tests': ['tsvgm']}}, 07:41:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['damp', 'tps']}, 07:41:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'tests': ['damp', 'tps']}, 07:41:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['dromaeo_dom']}, 07:41:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['basic_compositor_video']}, 07:41:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:41:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['tsvgx', 07:41:31 INFO - 'tsvgr_opacity', 07:41:31 INFO - 'tart', 07:41:31 INFO - 'tscrollx', 07:41:31 INFO - 'cart']}, 07:41:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:31 INFO - 'tsvgr_opacity', 07:41:31 INFO - 'tart', 07:41:31 INFO - 'tscrollx', 07:41:31 INFO - 'cart']}, 07:41:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['tp5o']}, 07:41:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'tests': ['tp5o']}, 07:41:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--disable-e10s', 07:41:31 INFO - '--xperf_path', 07:41:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:31 INFO - 'tests': ['tp5n']}, 07:41:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--xperf_path', 07:41:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:31 INFO - 'tests': ['tp5n']}}, 07:41:31 INFO - 'talos.zip': {'path': '', 07:41:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:31 INFO - Running post-action listener: _resource_record_post_action 07:41:31 INFO - [mozharness: 2016-12-06 15:41:31.441307Z] Finished populate-webroot step (success) 07:41:31 INFO - [mozharness: 2016-12-06 15:41:31.441395Z] Running create-virtualenv step. 07:41:31 INFO - Running pre-action listener: _resource_record_pre_action 07:41:31 INFO - Running main action method: create_virtualenv 07:41:31 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:31 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 07:41:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:31 INFO - Using real prefix '/usr' 07:41:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:32 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:34 INFO - Installing pip.................done. 07:41:34 INFO - Return code: 0 07:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:41:34 INFO - Reading from file tmpfile_stdout 07:41:34 INFO - Output received: 07:41:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:41:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:41:34 INFO - Using env: {'DISPLAY': ':0', 07:41:34 INFO - 'HOME': '/home/cltbld', 07:41:34 INFO - 'LANG': 'en_US.UTF-8', 07:41:34 INFO - 'LANGUAGE': 'en_US:en', 07:41:34 INFO - 'LOGNAME': 'cltbld', 07:41:34 INFO - 'MAIL': '/var/mail/cltbld', 07:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:34 INFO - 'MOZ_NO_REMOTE': '1', 07:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:34 INFO - 'NO_EM_RESTART': '1', 07:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:34 INFO - 'PWD': '/builds/slave/test', 07:41:34 INFO - 'SHELL': '/bin/bash', 07:41:34 INFO - 'SHLVL': '1', 07:41:34 INFO - 'TERM': 'linux', 07:41:34 INFO - 'TMOUT': '86400', 07:41:34 INFO - 'USER': 'cltbld', 07:41:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:34 INFO - '_': '/tools/buildbot/bin/python'} 07:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:34 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 07:41:34 INFO - Cleaning up... 07:41:34 INFO - Return code: 0 07:41:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:41:34 INFO - Using env: {'DISPLAY': ':0', 07:41:34 INFO - 'HOME': '/home/cltbld', 07:41:34 INFO - 'LANG': 'en_US.UTF-8', 07:41:34 INFO - 'LANGUAGE': 'en_US:en', 07:41:34 INFO - 'LOGNAME': 'cltbld', 07:41:34 INFO - 'MAIL': '/var/mail/cltbld', 07:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:34 INFO - 'MOZ_NO_REMOTE': '1', 07:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:34 INFO - 'NO_EM_RESTART': '1', 07:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:34 INFO - 'PWD': '/builds/slave/test', 07:41:34 INFO - 'SHELL': '/bin/bash', 07:41:34 INFO - 'SHLVL': '1', 07:41:34 INFO - 'TERM': 'linux', 07:41:34 INFO - 'TMOUT': '86400', 07:41:34 INFO - 'USER': 'cltbld', 07:41:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:34 INFO - '_': '/tools/buildbot/bin/python'} 07:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:34 INFO - Downloading/unpacking psutil>=3.1.1 07:41:34 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 07:41:34 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 07:41:34 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 07:41:34 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 07:41:34 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 07:41:34 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 07:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:36 INFO - Installing collected packages: psutil 07:41:36 INFO - Running setup.py install for psutil 07:41:36 INFO - building 'psutil._psutil_linux' extension 07:41:36 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 07:41:36 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 07:41:37 INFO - building 'psutil._psutil_posix' extension 07:41:37 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 07:41:37 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 07:41:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:37 INFO - Successfully installed psutil 07:41:37 INFO - Cleaning up... 07:41:37 INFO - Return code: 0 07:41:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:41:37 INFO - Using env: {'DISPLAY': ':0', 07:41:37 INFO - 'HOME': '/home/cltbld', 07:41:37 INFO - 'LANG': 'en_US.UTF-8', 07:41:37 INFO - 'LANGUAGE': 'en_US:en', 07:41:37 INFO - 'LOGNAME': 'cltbld', 07:41:37 INFO - 'MAIL': '/var/mail/cltbld', 07:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:37 INFO - 'MOZ_NO_REMOTE': '1', 07:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:37 INFO - 'NO_EM_RESTART': '1', 07:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:37 INFO - 'PWD': '/builds/slave/test', 07:41:37 INFO - 'SHELL': '/bin/bash', 07:41:37 INFO - 'SHLVL': '1', 07:41:37 INFO - 'TERM': 'linux', 07:41:37 INFO - 'TMOUT': '86400', 07:41:37 INFO - 'USER': 'cltbld', 07:41:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:37 INFO - '_': '/tools/buildbot/bin/python'} 07:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:41:39 INFO - Installing collected packages: mozsystemmonitor 07:41:39 INFO - Running setup.py install for mozsystemmonitor 07:41:39 INFO - Successfully installed mozsystemmonitor 07:41:39 INFO - Cleaning up... 07:41:39 INFO - Return code: 0 07:41:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:41:39 INFO - Using env: {'DISPLAY': ':0', 07:41:39 INFO - 'HOME': '/home/cltbld', 07:41:39 INFO - 'LANG': 'en_US.UTF-8', 07:41:39 INFO - 'LANGUAGE': 'en_US:en', 07:41:39 INFO - 'LOGNAME': 'cltbld', 07:41:39 INFO - 'MAIL': '/var/mail/cltbld', 07:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:39 INFO - 'MOZ_NO_REMOTE': '1', 07:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:39 INFO - 'NO_EM_RESTART': '1', 07:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:39 INFO - 'PWD': '/builds/slave/test', 07:41:39 INFO - 'SHELL': '/bin/bash', 07:41:39 INFO - 'SHLVL': '1', 07:41:39 INFO - 'TERM': 'linux', 07:41:39 INFO - 'TMOUT': '86400', 07:41:39 INFO - 'USER': 'cltbld', 07:41:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:39 INFO - '_': '/tools/buildbot/bin/python'} 07:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:39 INFO - Downloading/unpacking jsonschema==2.5.1 07:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:41:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:42 INFO - Downloading functools32-3.2.3-2.tar.gz 07:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:41:42 INFO - warning: no files found matching '*.txt' 07:41:42 INFO - no previously-included directories found matching 'build' 07:41:42 INFO - no previously-included directories found matching 'dist' 07:41:42 INFO - no previously-included directories found matching '.git*' 07:41:42 INFO - Installing collected packages: jsonschema, functools32 07:41:42 INFO - Running setup.py install for functools32 07:41:42 INFO - warning: no files found matching '*.txt' 07:41:42 INFO - no previously-included directories found matching 'build' 07:41:42 INFO - no previously-included directories found matching 'dist' 07:41:42 INFO - no previously-included directories found matching '.git*' 07:41:42 INFO - Successfully installed jsonschema functools32 07:41:42 INFO - Cleaning up... 07:41:42 INFO - Return code: 0 07:41:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:41:42 INFO - Using env: {'DISPLAY': ':0', 07:41:42 INFO - 'HOME': '/home/cltbld', 07:41:42 INFO - 'LANG': 'en_US.UTF-8', 07:41:42 INFO - 'LANGUAGE': 'en_US:en', 07:41:42 INFO - 'LOGNAME': 'cltbld', 07:41:42 INFO - 'MAIL': '/var/mail/cltbld', 07:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:42 INFO - 'MOZ_NO_REMOTE': '1', 07:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:42 INFO - 'NO_EM_RESTART': '1', 07:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:42 INFO - 'PWD': '/builds/slave/test', 07:41:42 INFO - 'SHELL': '/bin/bash', 07:41:42 INFO - 'SHLVL': '1', 07:41:42 INFO - 'TERM': 'linux', 07:41:42 INFO - 'TMOUT': '86400', 07:41:42 INFO - 'USER': 'cltbld', 07:41:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:42 INFO - '_': '/tools/buildbot/bin/python'} 07:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:41:42 INFO - Cleaning up... 07:41:42 INFO - Return code: 0 07:41:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:42 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 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:42 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 07:41:42 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 07:41:42 INFO - Using env: {'DISPLAY': ':0', 07:41:42 INFO - 'HOME': '/home/cltbld', 07:41:42 INFO - 'LANG': 'en_US.UTF-8', 07:41:42 INFO - 'LANGUAGE': 'en_US:en', 07:41:42 INFO - 'LOGNAME': 'cltbld', 07:41:42 INFO - 'MAIL': '/var/mail/cltbld', 07:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:42 INFO - 'MOZ_NO_REMOTE': '1', 07:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:42 INFO - 'NO_EM_RESTART': '1', 07:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:42 INFO - 'PWD': '/builds/slave/test', 07:41:42 INFO - 'SHELL': '/bin/bash', 07:41:42 INFO - 'SHLVL': '1', 07:41:42 INFO - 'TERM': 'linux', 07:41:42 INFO - 'TMOUT': '86400', 07:41:42 INFO - 'USER': 'cltbld', 07:41:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:42 INFO - '_': '/tools/buildbot/bin/python'} 07:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:42 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:44 INFO - Downloading blobuploader-1.2.4.tar.gz 07:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:41:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:41:45 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 07:41:45 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 07:41:45 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 07:41:45 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 07:41:45 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 07:41:45 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 07:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:41:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:41:45 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 07:41:45 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 07:41:45 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 07:41:45 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 07:41:45 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 07:41:45 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 07:41:45 INFO - Downloading docopt-0.6.1.tar.gz 07:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:41:45 INFO - Installing collected packages: blobuploader, requests, docopt 07:41:45 INFO - Running setup.py install for blobuploader 07:41:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:41:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:41:45 INFO - Running setup.py install for requests 07:41:46 INFO - Running setup.py install for docopt 07:41:46 INFO - Successfully installed blobuploader requests docopt 07:41:46 INFO - Cleaning up... 07:41:46 INFO - Return code: 0 07:41:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:46 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 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:46 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 07:41:46 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 07:41:46 INFO - Using env: {'DISPLAY': ':0', 07:41:46 INFO - 'HOME': '/home/cltbld', 07:41:46 INFO - 'LANG': 'en_US.UTF-8', 07:41:46 INFO - 'LANGUAGE': 'en_US:en', 07:41:46 INFO - 'LOGNAME': 'cltbld', 07:41:46 INFO - 'MAIL': '/var/mail/cltbld', 07:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:46 INFO - 'MOZ_NO_REMOTE': '1', 07:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:46 INFO - 'NO_EM_RESTART': '1', 07:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:46 INFO - 'PWD': '/builds/slave/test', 07:41:46 INFO - 'SHELL': '/bin/bash', 07:41:46 INFO - 'SHLVL': '1', 07:41:46 INFO - 'TERM': 'linux', 07:41:46 INFO - 'TMOUT': '86400', 07:41:46 INFO - 'USER': 'cltbld', 07:41:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:46 INFO - '_': '/tools/buildbot/bin/python'} 07:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:46 INFO - Running setup.py (path:/tmp/pip-tcKFQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:46 INFO - Running setup.py (path:/tmp/pip-J5EQZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:46 INFO - Running setup.py (path:/tmp/pip-7QyxVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:46 INFO - Running setup.py (path:/tmp/pip-U7JB54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:46 INFO - Running setup.py (path:/tmp/pip-c48oy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:46 INFO - Running setup.py (path:/tmp/pip-d6WX9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:47 INFO - Running setup.py (path:/tmp/pip-O0CKXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:47 INFO - Running setup.py (path:/tmp/pip-ldLJoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:47 INFO - Running setup.py (path:/tmp/pip-r3_aAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:47 INFO - Running setup.py (path:/tmp/pip-Odu7Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:47 INFO - Running setup.py (path:/tmp/pip-bFAhFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:47 INFO - Running setup.py (path:/tmp/pip-4QM6m6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:47 INFO - Running setup.py (path:/tmp/pip-I4jc4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:47 INFO - Running setup.py (path:/tmp/pip-E1UkNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:47 INFO - Running setup.py (path:/tmp/pip-jiGYzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:47 INFO - Running setup.py (path:/tmp/pip-ii5yVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:47 INFO - Running setup.py (path:/tmp/pip-GWSi7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:41:47 INFO - Running setup.py install for manifestparser 07:41:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:41:47 INFO - Running setup.py install for mozcrash 07:41:48 INFO - Running setup.py install for mozdebug 07:41:48 INFO - Running setup.py install for mozdevice 07:41:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozfile 07:41:48 INFO - Running setup.py install for mozhttpd 07:41:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozinfo 07:41:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozInstall 07:41:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozleak 07:41:48 INFO - Running setup.py install for mozlog 07:41:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for moznetwork 07:41:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozprocess 07:41:49 INFO - Running setup.py install for mozprofile 07:41:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:41:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:41:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:41:49 INFO - Running setup.py install for mozrunner 07:41:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:41:49 INFO - Running setup.py install for mozscreenshot 07:41:49 INFO - Running setup.py install for moztest 07:41:49 INFO - Running setup.py install for mozversion 07:41:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:41:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:41:49 INFO - Cleaning up... 07:41:49 INFO - Return code: 0 07:41:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:49 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 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:49 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 07:41:49 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 07:41:49 INFO - Using env: {'DISPLAY': ':0', 07:41:49 INFO - 'HOME': '/home/cltbld', 07:41:49 INFO - 'LANG': 'en_US.UTF-8', 07:41:49 INFO - 'LANGUAGE': 'en_US:en', 07:41:49 INFO - 'LOGNAME': 'cltbld', 07:41:49 INFO - 'MAIL': '/var/mail/cltbld', 07:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:49 INFO - 'MOZ_NO_REMOTE': '1', 07:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:49 INFO - 'NO_EM_RESTART': '1', 07:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:49 INFO - 'PWD': '/builds/slave/test', 07:41:49 INFO - 'SHELL': '/bin/bash', 07:41:49 INFO - 'SHLVL': '1', 07:41:49 INFO - 'TERM': 'linux', 07:41:49 INFO - 'TMOUT': '86400', 07:41:49 INFO - 'USER': 'cltbld', 07:41:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:49 INFO - '_': '/tools/buildbot/bin/python'} 07:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:49 INFO - Running setup.py (path:/tmp/pip-ZZB9Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:49 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)) 07:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:49 INFO - Running setup.py (path:/tmp/pip-5B3RgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:50 INFO - Running setup.py (path:/tmp/pip-1PoCvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:50 INFO - Running setup.py (path:/tmp/pip-ad8995-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:50 INFO - Running setup.py (path:/tmp/pip-49uSqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:50 INFO - Running setup.py (path:/tmp/pip-lUSnX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:50 INFO - Running setup.py (path:/tmp/pip-147FMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:50 INFO - Running setup.py (path:/tmp/pip-a3aV5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:50 INFO - Running setup.py (path:/tmp/pip-_4ixHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:50 INFO - Running setup.py (path:/tmp/pip-X3AZW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:50 INFO - Running setup.py (path:/tmp/pip-s507dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:50 INFO - Running setup.py (path:/tmp/pip-A5mQEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:50 INFO - Running setup.py (path:/tmp/pip-opfIcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:50 INFO - Running setup.py (path:/tmp/pip-alPJl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:50 INFO - Running setup.py (path:/tmp/pip-jFnhmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:50 INFO - Running setup.py (path:/tmp/pip-8GPx_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:51 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)) 07:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:51 INFO - Running setup.py (path:/tmp/pip-V2YSL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:51 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)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:41:51 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)) 07:41:51 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)) 07:41:51 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)) 07:41:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:41:51 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 07:41:51 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 07:41:51 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 07:41:51 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 07:41:51 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 07:41:51 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 07:41:53 INFO - Downloading blessings-1.6.tar.gz 07:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:41:53 INFO - Installing collected packages: blessings 07:41:53 INFO - Running setup.py install for blessings 07:41:53 INFO - Successfully installed blessings 07:41:53 INFO - Cleaning up... 07:41:53 INFO - Return code: 0 07:41:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:53 INFO - Reading from file tmpfile_stdout 07:41:53 INFO - Current package versions: 07:41:53 INFO - argparse == 1.2.1 07:41:53 INFO - blessings == 1.6 07:41:53 INFO - blobuploader == 1.2.4 07:41:53 INFO - docopt == 0.6.1 07:41:53 INFO - functools32 == 3.2.3-2 07:41:53 INFO - jsonschema == 2.5.1 07:41:53 INFO - manifestparser == 1.1 07:41:53 INFO - mozInstall == 1.12 07:41:53 INFO - mozcrash == 1.0 07:41:53 INFO - mozdebug == 0.1 07:41:53 INFO - mozdevice == 0.48 07:41:53 INFO - mozfile == 1.2 07:41:53 INFO - mozhttpd == 0.7 07:41:53 INFO - mozinfo == 0.9 07:41:53 INFO - mozleak == 0.1 07:41:53 INFO - mozlog == 3.4 07:41:53 INFO - moznetwork == 0.27 07:41:53 INFO - mozprocess == 0.23 07:41:53 INFO - mozprofile == 0.28 07:41:53 INFO - mozrunner == 6.13 07:41:53 INFO - mozscreenshot == 0.1 07:41:53 INFO - mozsystemmonitor == 0.3 07:41:53 INFO - moztest == 0.7 07:41:53 INFO - mozversion == 1.4 07:41:53 INFO - psutil == 3.1.1 07:41:53 INFO - requests == 1.2.3 07:41:53 INFO - wsgiref == 0.1.2 07:41:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 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 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:53 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 07:41:53 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 07:41:53 INFO - Using env: {'DISPLAY': ':0', 07:41:53 INFO - 'HOME': '/home/cltbld', 07:41:53 INFO - 'LANG': 'en_US.UTF-8', 07:41:53 INFO - 'LANGUAGE': 'en_US:en', 07:41:53 INFO - 'LOGNAME': 'cltbld', 07:41:53 INFO - 'MAIL': '/var/mail/cltbld', 07:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:53 INFO - 'MOZ_NO_REMOTE': '1', 07:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:53 INFO - 'NO_EM_RESTART': '1', 07:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:53 INFO - 'PWD': '/builds/slave/test', 07:41:53 INFO - 'SHELL': '/bin/bash', 07:41:53 INFO - 'SHLVL': '1', 07:41:53 INFO - 'TERM': 'linux', 07:41:53 INFO - 'TMOUT': '86400', 07:41:53 INFO - 'USER': 'cltbld', 07:41:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:53 INFO - '_': '/tools/buildbot/bin/python'} 07:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 INFO - Cleaning up... 07:41:53 INFO - Return code: 0 07:41:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ec21b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1841ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, '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': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', '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 07:41:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:41:53 INFO - Using env: {'DISPLAY': ':0', 07:41:53 INFO - 'HOME': '/home/cltbld', 07:41:53 INFO - 'LANG': 'en_US.UTF-8', 07:41:53 INFO - 'LANGUAGE': 'en_US:en', 07:41:53 INFO - 'LOGNAME': 'cltbld', 07:41:53 INFO - 'MAIL': '/var/mail/cltbld', 07:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:53 INFO - 'MOZ_NO_REMOTE': '1', 07:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:53 INFO - 'NO_EM_RESTART': '1', 07:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:53 INFO - 'PWD': '/builds/slave/test', 07:41:53 INFO - 'SHELL': '/bin/bash', 07:41:53 INFO - 'SHLVL': '1', 07:41:53 INFO - 'TERM': 'linux', 07:41:53 INFO - 'TMOUT': '86400', 07:41:53 INFO - 'USER': 'cltbld', 07:41:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:53 INFO - '_': '/tools/buildbot/bin/python'} 07:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:41:54 INFO - Cleaning up... 07:41:54 INFO - Return code: 0 07:41:54 INFO - Running post-action listener: _resource_record_post_action 07:41:54 INFO - Running post-action listener: _start_resource_monitoring 07:41:54 INFO - Starting resource monitoring. 07:41:54 INFO - [mozharness: 2016-12-06 15:41:54.104272Z] Finished create-virtualenv step (success) 07:41:54 INFO - [mozharness: 2016-12-06 15:41:54.104782Z] Running install step. 07:41:54 INFO - Running pre-action listener: _resource_record_pre_action 07:41:54 INFO - Running main action method: install 07:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:54 INFO - Reading from file tmpfile_stdout 07:41:54 INFO - Detecting whether we're running mozinstall >=1.0... 07:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:41:54 INFO - Reading from file tmpfile_stdout 07:41:54 INFO - Output received: 07:41:54 INFO - Usage: mozinstall [options] installer 07:41:54 INFO - Options: 07:41:54 INFO - -h, --help show this help message and exit 07:41:54 INFO - -d DEST, --destination=DEST 07:41:54 INFO - Directory to install application into. [default: 07:41:54 INFO - "/builds/slave/test"] 07:41:54 INFO - --app=APP Application being installed. [default: firefox] 07:41:54 INFO - mkdir: /builds/slave/test/build/application 07:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:42:10 INFO - Reading from file tmpfile_stdout 07:42:10 INFO - Output received: 07:42:10 INFO - /builds/slave/test/build/application/firefox/firefox 07:42:10 INFO - Running post-action listener: _resource_record_post_action 07:42:10 INFO - [mozharness: 2016-12-06 15:42:10.367672Z] Finished install step (success) 07:42:10 INFO - [mozharness: 2016-12-06 15:42:10.367916Z] Running run-tests step. 07:42:10 INFO - Running pre-action listener: _resource_record_pre_action 07:42:10 INFO - Running main action method: run_tests 07:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:10 INFO - Python 2.7.3 07:42:10 INFO - Return code: 0 07:42:10 INFO - grabbing minidump binary from tooltool 07:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183ef60>, '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 0x183fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18401d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:10 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 07:42:10 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 07:42:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:42:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:10 INFO - Return code: 0 07:42:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:42:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:42:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 07:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 07:42:10 INFO - Using env: {'DISPLAY': ':0', 07:42:10 INFO - 'HOME': '/home/cltbld', 07:42:10 INFO - 'LANG': 'en_US.UTF-8', 07:42:10 INFO - 'LANGUAGE': 'en_US:en', 07:42:10 INFO - 'LOGNAME': 'cltbld', 07:42:10 INFO - 'MAIL': '/var/mail/cltbld', 07:42:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:10 INFO - 'MOZ_NO_REMOTE': '1', 07:42:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:10 INFO - 'NO_EM_RESTART': '1', 07:42:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:10 INFO - 'PWD': '/builds/slave/test', 07:42:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:10 INFO - 'SHELL': '/bin/bash', 07:42:10 INFO - 'SHLVL': '1', 07:42:10 INFO - 'TERM': 'linux', 07:42:10 INFO - 'TMOUT': '86400', 07:42:10 INFO - 'USER': 'cltbld', 07:42:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1481020656.893036-420408684', 07:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:10 INFO - '_': '/tools/buildbot/bin/python'} 07:42:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 07:42:10 INFO - mozversion application_buildid: 20161206055938 07:42:10 INFO - mozversion application_changeset: 48a4769a75a5d459dd86c4a1a2f9babb75c9eede 07:42:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:42:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:10 INFO - mozversion application_name: Firefox 07:42:10 INFO - mozversion application_remotingname: firefox-dev 07:42:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:42:10 INFO - mozversion application_vendor: Mozilla 07:42:10 INFO - mozversion application_version: 52.0a2 07:42:10 INFO - mozversion platform_buildid: 20161206055938 07:42:10 INFO - mozversion platform_changeset: 48a4769a75a5d459dd86c4a1a2f9babb75c9eede 07:42:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:42:10 INFO - mozversion platform_version: 52.0a2 07:42:10 INFO - using testdate: 1481038930 07:42:10 INFO - actual date: 1481038930 07:42:10 INFO - starting webserver on 'localhost:37331' 07:42:10 INFO - SUITE-START | Running 2 tests 07:42:10 INFO - TEST-START | dromaeo_css 07:42:10 INFO - operating with platform_type : linux_ 07:42:10 INFO - Initialising browser for dromaeo_css test... 07:42:10 INFO - TEST-INFO | started process 5597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZv4oEE/profile http://localhost:37331/getInfo.html) 07:42:14 INFO - PROCESS | 5597 | __metrics Screen width/height:1600/1200 07:42:14 INFO - PROCESS | 5597 | colorDepth:24 07:42:14 INFO - PROCESS | 5597 | Browser inner width/height: 1024/697 07:42:14 INFO - PROCESS | 5597 | __metrics 07:42:15 INFO - PROCESS | 5597 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:42:15 INFO - PROCESS | 5597 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:42:15 INFO - PROCESS | 5597 | console.error: PushService: 07:42:15 INFO - PROCESS | 5597 | stateChangeProcessEnqueue: Error transitioning state 07:42:15 INFO - PROCESS | 5597 | UnknownError 07:42:16 INFO - TEST-INFO | 5597: exit 0 07:42:16 INFO - Browser initialized. 07:42:16 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:16 INFO - TEST-INFO | started process 5688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZv4oEE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:28 INFO - PROCESS | 5688 | RSS: Main: 147255296 07:42:28 INFO - PROCESS | 5688 | 07:43:19 INFO - PROCESS | 5688 | 1481038999424 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] 07:45:29 INFO - PROCESS | 5688 | Cycle 1(1): loaded http://localhost:37331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37331/tests/dromaeo/cssquery-ext.html) 07:45:31 INFO - PROCESS | 5688 | RSS: Main: 245866496 07:45:31 INFO - PROCESS | 5688 | 07:48:33 INFO - PROCESS | 5688 | Cycle 1(1): loaded http://localhost:37331/tests/dromaeo/cssquery-ext.html (next: http://localhost:37331/tests/dromaeo/cssquery-jquery.html) 07:48:33 INFO - PROCESS | 5688 | RSS: Main: 234893312 07:48:33 INFO - PROCESS | 5688 | 07:51:35 INFO - PROCESS | 5688 | Cycle 1(1): loaded http://localhost:37331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37331/tests/dromaeo/cssquery-mootools.html) 07:51:36 INFO - PROCESS | 5688 | RSS: Main: 177893376 07:51:36 INFO - PROCESS | 5688 | 07:54:38 INFO - PROCESS | 5688 | Cycle 1(1): loaded http://localhost:37331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37331/tests/dromaeo/cssquery-prototype.html) 07:54:39 INFO - PROCESS | 5688 | RSS: Main: 174297088 07:54:39 INFO - PROCESS | 5688 | 07:57:41 INFO - PROCESS | 5688 | Cycle 1(1): loaded http://localhost:37331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37331/tests/dromaeo/cssquery-yui.html) 07:57:42 INFO - PROCESS | 5688 | RSS: Main: 175964160 07:57:42 INFO - PROCESS | 5688 | 08:00:44 INFO - PROCESS | 5688 | Cycle 1(1): loaded http://localhost:37331/tests/dromaeo/cssquery-yui.html (next: http://localhost:37331/tests/dromaeo/cssquery-dojo.html) 08:00:45 INFO - PROCESS | 5688 | RSS: Main: 262463488 08:00:45 INFO - PROCESS | 5688 | 08:00:45 INFO - PROCESS | 5688 | __start_tp_report 08:00:45 INFO - PROCESS | 5688 | _x_x_mozilla_page_load 08:00:45 INFO - PROCESS | 5688 | _x_x_mozilla_page_load_details 08:00:45 INFO - PROCESS | 5688 | |i|pagename|runs| 08:00:45 INFO - PROCESS | 5688 | |0;dojo.html;3166.9366612667745;3169.302753394253;3179.586653735014;3205.214722393014;3210.165357007179;5425.511703946644;5489.972550137249;5500.972495137524;5523.392426833045;5538.141588053848;5523.797161215602;5555.3611334696525;5572.832815015546;5574.60977731559;5575.8606034849145;5012.874678133039;5023.32185155003;5046.470120637336;5076.390833100033;5094.439611642735;4965.3048573199785;4967.5280848319535;5004.924926126111;5055.31753213317;5106.795728170887;5034.521720436571;5105.872353191163;5120.180771076629;5140.2546630738525;5143.202803565453;5123.846284611468;5124.0776660201145;5124.795008199686;5128.5640720538795;5165.018646457199;4860.149473842063;4868.488808675109;5035.798568057273;5045.949540504622;5101.566366858784;5423;5428.83713488596;5461.1808228766;5489.451054894518;5511.3937466878615;5882;5897.262842144732;5925.792597259076;5956.672383018932;5971.880562388771;5772.826815195551;5994.610350327215;5997.040473524259;6007.15899774032;6008.48927841134;5449.700266485342;5470.987867244572;5520.972395137998;5559.861003474864;5605.495505404533;6076.5442591805795;6080.57435979486;6084.11780291864;6090.756369745161;6097.451229389288;5695.060315048054;5819.82540523785;5831.825045248649;5837.153612726131;5837.88324233513;5816.272965879265;5832.854178645568;5898.026825573818;5901.321348044944;5988.131720900445;5851.970740146272;5899.233099697098;5899.380565040695;5901.527877769769;5902.970485147547;5895.35151133375;5918.704064796743;5929.792457263975;5931.139984702194;5934.554908381889;4479.59683628475;4514.34541991416;4541.250693635513;4566.84016059443;4590.081983603292;4074.9796251018556;4077.734947228421;4093.5292441369625;4101.651359634405;4107.732997355162;5693.914591281134;5711.8857622848145;5711.971440142773;5720.141978703228;5754.482096611241;5719.256496655491;5774.047282198474;5910.468057874812;5987.550933679904;5992.58051936369;5640.8871822563315;5716.056850619684;5716.085426331767;5723.828285151452;5742.827715168552;5177.896442071137;5207.453217412193;5219.530242278213;5220.791168353299;5222.399424066205;5953.493953014043;6014.518838492998;6037.879242415039;6143.477804386588;6193.721282542297;5817.389174136655;5892.204552385373;5898.292204935264;5914.260717410324;5934.169216309807;6163.476104531165;6164.4143806338325;6167.753289868355;6168.938310617016;6172.876542469216;5540.501354878081;5602.1036634138345;5805.042168042226;5811.912821307768;5812.273465816773;5838.2702162229725;5841;5864.589478736448;5929.851753706192;5967.731452084753;5734.627249228787;5803.8549036274435;5826.329972053099;5833.504152146946;5845.064789633639;5624.746886390204;5790.594658373873;5805.3614102447855;5808.564357673107;5811.099279611667;5631.3242410909315;5696.715164241854;5721.971390143022;5746.2529871116485;5779.0464573344925;5800.970995144998;5805.651660900359;5830.5627077968475;5830.979578573818;5842.7662893485485;5549.500544950974;5612.438756124355;5652.434756524314;5696.202531645656;5712.65724056558 08:00:45 INFO - PROCESS | 5688 | |1;ext.html;585.961912475689;612.4059662127737;634.8666779976203;652.3215855510267;673.1686367336342;34997.47503787442;35659.10852228692;37642.811785941034;37726;37774.43338349927;47589.524104758944;48633.51366486334;48636.513634863644;50840.71216795253;51123;8696.999999999984;8848.070952549953;8856.158664926821;8857.645694172257;8865.601047952858;8423.620937057847;8647.481151130953;8783.253423459013;8876.911230887705;10358.171346292316;10486.737831554196;10882.29265097766;10888.237823352369;10891.237613367068;10900.672979810619;10538;10631.308964917256;10631.308964917333;10634;10635.415052172166;10488.947555262175;10535.947320263349;10547.525361358681;10552.419616921066;10560.52477638508;43769;44079.33880991788;44101.33847992283;44113.558864411265;44196.55803441956;3858;3884.126071633888;3945.5857135000697;4161.895952601179;4447.599716025573;32324.515132273034;32493.51259731106;32785.50821737676;33048.3390332192;33135.502967455504;4460.888477788081;4505.2791553351635;4526.23054080807;4547.681662283609;4559.498455169929;353717;356370;356914.2154289238;357302;360352;63826;63832.36167638264;63945.680271599274;64107;64240.036399454046;40129.79935100306;67308;67358;67449.65100697959;67474;18504.907475462536;19182;19213.32753353626;19216.71174932377;19219;14721.55835324942;14812.185329806749;14817.70364592702;14830.629234269014;14833.777493337608;18442.63114737698;18896.338628147947;19690.21239150418;20973;21109.788902110784;7267.672954717051;7370.96314518424;7484.401247900155;7580.583067931317;7640.465167438226;914.8993610702818;1121.8373335866418;1123.5674265407713;1126.6649020910247;1127.1771606727134;33111.3377732444;33355.332893342;33642.66357336444;33647.32705345928;34135.48796768051;1125.6848082536903;1148.9487119285927;1186.7329850783506;1211.3654582702497;1221.883921027501;17725;18218.45344639663;18364.173612187482;18396.81603183978;18459.261629534667;560453;563175;566868;567393;567785;63235;63827.680861596324;63842.361576384574;63944.36055639384;64094.67952660207;1330.6473784446935;1384.1141669331637;1399.2863639543702;1447.7176950494763;1451.4702133721116;31789;34384.48423273703;35183.29633407369;35371.93884183479;35493.29013419769;55446;55962.440375597354;55963.44036559582;56011.43988560225;56015;407719;409956;410017;410176;411014;30389.544156837223;32829.671703282664;32833.67166328402;33181.50227746634;33384.666153338156;49282.26076608782;49314.50685493243;49698.75150624224;50420.74789626028;51080;42484.575154248065;42623.786881065396;42658;43153.56846431496;44017.339739903284;41872.79063604662;41958.790206048776;42740.358894617224;43819;44303.778481108675;43368;44086;44760.10479790321;44835.77582112199;44988.100237994404;35994.64005359913;38421.231575367776;38776.80611596924;38813.611863881;38916.27324023155;29110.563341550318;29201.7079829199;29382.265443364086;29399.50332611974;29671.25821854471 08:00:45 INFO - PROCESS | 5688 | |2;jquery.html;401.41593980758;414.15099046953736;427.96148346648806;429.67559492583104;431.1205141511317;14549.854501454982;16048.839511604894;19453.805461945394;19697.704534431996;20297.39107826764;19579.118939647713;19790.90104549479;19933.3023344183;20106.396808095782;20289.59420811583;5547.805826796063;5670.121131224657;5710.800121995731;5767.769289228426;5855.765769369242;4303.935440968388;4548.044910568785;5643.4074422185695;5776.942230577703;5789.218455508516;6011.639301641915;6288.496920246393;6312.684365781715;6397.808065758035;6435.903461448082;6260.436560709535;6431.389018043302;6504.349565043482;6538.280789113193;6540;5788.305403351625;5869.50109240715;5876.3242227144;5876.6180198286975;5879.8236052918055;23630.64554031691;23921.88039059811;24091.39771505709;24476.632850507256;24947.50104997908;2506.52376048552;2596.5066637338846;2612.373030472692;2748.573971034493;2884.798064135511;14532.927335363362;14977.176255305954;15109.54671359861;15385.769213461806;15876;1942.5920556682972;1973.8124878136555;1975.6838905775007;1984.3848406993877;2061.185831596511;55637;88269.55865220632;88281;89040;90254.5487272566;11248.325100493996;11352.54589816398;11412.201145919871;11598.130140239517;11611.767764644828;16676.74984875228;16682.666346673;16695.415660451825;16719.665606688042;16725.91637041807;8676.219140277406;8707.521086340312;8759.255463285692;8909.376343656011;8966.820663586692;8385.748427547183;8415.116412776693;8416.957915210385;8648.870266946002;8675.479471231747;6938.202106757787;6965.616891071039;7028.824279392954;7087.503874728823;7118.252583478764;1956.8238858502802;1996.1217064491577;2013.4395593979648;2039.9796002040086;2041.275347251734;928.178561972659;980.2892902645667;981.842905135175;1036.160709825029;1056.99471502642;18971.620567588572;19872.90063549673;20085.39743807688;21431.89284053601;21536.56926861454;1001.7145113642576;1017.730301470111;1020.0717347213999;1028.753099256173;1071.7642118733866;10421.374717516821;11366.545338186379;11470.655880323604;11473.024792892531;11490.770184596262;462586;469536;469806;483923;500714;83710.58144709238;93512;94149.5292523533;99179.50410247903;99228;1000.5747557288123;1026.7997740440542;1052.7420781908481;1060.3319908457622;1073.5115522437115;17914.193861276013;18190.5452363692;18483;18671.90664046671;19006.904965475638;42098;43000.78499607482;43275.567244327154;43367.78316108399;44637.553624464636;57996;59559.70220148871;60998.695006524686;61399.69300153471;62593.37406626058;8522.190391912758;8901.287896968357;8953.552322383724;8955.656651502066;9161.496117713323;11888;12934.288614125937;13021.414036368196;13266.80099798523;13377.464901403835;11142.220044596801;11154.888451115385;11256.493457794582;11528.769424611628;11996.520139194334;10975.83536246941;11264.267822591506;11522.135839812216;11668.949794518534;11726.296422214695;10992.450377481255;11532.82700759506;11746.236494627821;11787.587434439753;11855.644330670093;8398.790030249049;8619;8675.002374726988;8741.606627701642;8870.556472176237;10517.737056573647;11069.280496767684;11417.771644566896;11873.703157420789;12193.939030304791 08:00:45 INFO - PROCESS | 5688 | |3;mootools.html;1342.8992825538076;1506.6685329227569;1514.2731488885336;1646.2098192867422;1790.221253754616;7919.920800791991;8641.308695304377;8916.46501209928;8930.017698053218;9135.451872887632;8850.601722922467;8931.37480376374;8936.553172341373;8937.642494300237;8943.239824614899;2511.5353659572993;2540.6316084167784;2543.923682289525;2544.6564713763682;2545.643609894616;2404.831661783676;2478.938026549342;2482.726900040994;2486.3908342456125;2487.452760392711;2422.6002709552904;2426.5996110641813;2482.726900040994;2487.141936032066;2487.5522405966917;2279.9202027929027;2286.4855407533337;2305.8155347572156;2402.2192787344184;2406.338256979327;2241.854279471829;2295.667128266409;2296.896639651203;2298.6666933294578;2312.190733243368;8776.912230877673;8888.822223555557;8964.551772411354;8994.235489983359;8997.865032024525;5429.592780541436;5623.240862483553;5662.745176467069;5664.631798933056;5687.800926967578;3454.9654503454894;3592.173800026009;3656.524651795276;3734.0851491384783;3734.3838266685966;1205.921615095016;1214.5445457953267;1241.3669028795289;1294.669859185911;1304.7586196553668;12237;12383.690407739788;12424.130310878241;12436.253824770632;12449;4700.637743384482;4744.976275118672;4814.759262036884;4887.926681099786;4890.315355850184;9955.153811926068;9965.850512242323;9967.750806229757;9982.550785214682;9984.650537231308;5537.612367134262;5615.719214039282;5625.987322281947;5628.634138780966;5631.521320687787;4423.734575925455;4572.8399506017795;4726.338312636233;5230.686158830483;5267.841964741064;4045.1707399982934;4064.9187016260103;4178.8537401191425;4178.958210417918;4183.142455796616;1237.5482948723652;1283.8202651628778;1286.3182513267982;1288.5876519513854;1300.2263653126374;949.7150854743687;970.8203982263304;974.7222041718077;982.945937973404;983.627710311222;5713.542916566665;6106.297775755845;6196.442320191204;6239.532035097386;6360.77737279193;472.43543964962225;487.2228795071855;496.86336257528745;504.2260130699359;524.5331654827207;4161.459010328698;4179.728317659343;4253.447051883297;4256.042390462121;4285.314349704033;10722.946385268024;10969.396683182502;11018;11057.391843448688;11067.280626759235;10978.451077446096;10982.945085274683;10983.670489885157;10988.230823842254;11005.944970275097;7789.922100778919;8108;8117.95941020303;8366.456180348257;8464.619092140869;6105.633661980295;6162.260528736401;6246.437820596168;6277.058441233851;6398.0402939559435;10058.497075146068;10090.949545252226;10172;10221.131203847755;10236.334638248787;9321.161095501437;9539.952300238454;10423.895761042595;10530.104941080093;10530.31552949056;7689.192634773492;7807.960960195162;7871.763847084597;7921.485103468256;8007.879881801894;8516.233538981522;8538.615762290836;8572.099929507312;8576.185262400062;8585.441946273471;7612.961935190288;7677;7722.189170137055;7736.535807851547;7765.107012693613;7136.429085673238;7296.635168241673;7470.589117598584;7516.24837516244;7753.379729621504;6794.150731158606;6864;6873.862522749617;6874.896876546756;6880.552764070319;4674.836380726794;4701.7414042228;4714.646401519831;4775.522447755336;4790.8323208687525;5038.319826823332;5053.494650534917;5165.715885626327;5218.373795144607;5240.554552863049 08:00:45 INFO - PROCESS | 5688 | |4;prototype.html;359.0789624612868;360.9602943676196;367.05666437256247;368.1734506033954;371.1074864949795;5315.309009828722;5335;5335.279737235482;5343.973280133599;5397.082495975684;5296.25852380667;5304.416514183436;5315.441878602739;5319.9202011969855;5326.493983071602;4154.210699967004;4183.477065366829;4196.832126714928;4208.747475151486;4221.662267018631;4170.228507726065;4191.140816132701;4198.20234155511;4199.853005144821;4215.3044747616605;4157.563455837124;4165.812538435777;4186.074405773348;4190.685698572619;4207.347861081522;4124.917501649965;4195.979020104911;4204.579542045802;4211.705180637326;4226.077134903611;3770.7549009314307;3772.6604605585353;3777.7922214278206;3784.7729136251914;3791.829367678461;5120.259111901934;5137.6660517066275;5143.794248230066;5161.81933632321;5163.586913046947;4708.552687494683;4759.61923046159;4803.135435621587;4806.774272560509;4806.831760888352;5497.5601951843755;5515.393306736296;5516;5528;5540.335159780811;4128.483939507561;4134.37984302354;4182.853600123981;4184.979075104605;4190.182914331706;5567.972160139173;5656.604037717361;5688.293511946399;5710.343310519261;5716.28546431696;4234.767087810138;4258.063226090318;4262.147570485915;4276.48682158143;4295.162443323522;4321.157374312042;4328.264195086843;4331.401159304455;4338.761368124783;4362.847300344536;4681.719096854132;4814.518548145227;4832.178529649968;4837.927431088537;4841.709497430165;5433.239346491494;5464.23500709901;5508.504234618904;5508.55931525477;5513.8345849624575;1425.7433661940743;1441.1265355038408;1447.334226255913;1464.912105273687;1471.2349578219266;987.7975015121883;1031.5925209542188;1036;1043.6921108273077;1060.931039482431;5140.7943682253035;5146.408163061295;5209.218617207373;5211.462618527544;5215.55667768244;5364.7049412282695;5414.593905457106;5435.972820135953;5469.2616496772425;5496.917546236809;4950.4059512858685;5190.169572868323;5207.661502002357;5208.583313334924;5238.292830467838;2878.56821476776;2888.595596616475;2893.8697758600915;2894.956575651367;2911;5631.211630371751;5665.745041473144;5687.345955215121;5694.320175548223;5696.177223288508;5209.765560549784;5472.330939063624;5517.393086760453;5525.231925783711;5533.671918739554;5615.017371959891;5773.278340207474;5774.249347584787;5817.214676018768;5868.149118377897;5640.492355688008;5662.235598194356;5682.176084467812;5688.634727665248;5693.459121383462;5274.340707411574;5394.352677678547;5410.97294513525;5488.38092762628;5630.943690563206;5855.970720146372;5865.533616595851;5868.559858010752;5871.706414679164;5888.440598143169;4137.8758637240935;4248.638865696327;4268.189044081614;4271.419574757359;4273.850415235452;5625.437456254342;5625.690587017753;5637.46444087811;5671.298610416941;5672.659640421588;5529.728162522561;5563.972180139073;5581.665100093845;5586.52514536269;5595.328560572757;5310.8937821244135;5560.777568897361;5564.666120032811;5605.607607467438;5607.355154157324;5568.387477377404;5573.247611572386;5578.972105139448;5585.245991791056;5593.9440605595055;5625.915611265917;5658.773649053992;5663.235463212413;5666.914996275142;5683.516901063291;5262.552683021986;5400.9459905400445;5516.862078448071;5532.778688852562;5537.6709589697375 08:00:45 INFO - PROCESS | 5688 | |5;yui.html;775.4959276470294;793.1513280789555;802.4062193976459;803.7548547692955;863.7408777366788;16026.67946641068;16188.028718276897;16365.099919504422;16587.17064146794;16822.15889205538;16029.679406411893;16044.75932861008;16047.35810567576;16088.678226435464;16133.919330403362;705.14677240539;832.0473058348188;850.6469815026757;850.783050322167;851.8083431227986;723.5550136665939;835.5070508400042;853.5689476814231;853.6542700206395;858.9785255368635;904.0913881549034;904.1004200820194;904.7692838326251;905.9728208153766;907.5552979040256;734.6326836581709;889.3952112563454;892.8437523433406;896.0680891872445;897.3001059173822;554.2102503931881;630.5428564290899;646.647577070493;647.6632151281354;652.1717418877998;15276.923615381851;15278.618034549114;15315.31081101353;15318.310676019495;15323.616909577238;14041.64895877601;14111.929440352733;14249;14253.572392828231;14271.500497482642;12457.626271211788;12518.311492867888;12642.431090600852;12669.239845609292;12911.418986145645;4585.174668559658;4620.19146649335;4632.606228470584;4651.720896746206;4764.356811830393;64711;66180.66909665421;66580.3341966579;67457.32542674559;67828.3217167827;11160.386178760245;11194.993543260189;11343.602973895873;11389.088872890148;11567.248128871597;20199.192032318835;20279.69580456265;20306.593868122556;20343.593128137356;20519.281825136048;7988.360931125496;8419.789505262417;8567.314614830799;8591.269742071869;8643.30853531716;4721.433427988663;4879.585235255043;4901.534354236342;4955.925661115086;4981.651284410056;3320.9833950830093;3419.1623052352334;3425.246445781924;3435.4503279475166;3436.1409647588102;597.2981746447906;607.3774381259157;610.8442347201435;616.2143267334185;629.8866204083309;597.8953683105439;670.872534218497;676.0569006236371;679.1341040173818;686.1046334533382;8885.378023538291;9199.540022998823;9270.44377337362;9390.295727820305;9433;644.6969924135649;703.8557095795452;768.1511929318023;789.9881501777478;814.5601375257295;4345.761457984459;4551.544845515422;4629.7222166669435;4668.183067963093;4674.587551087725;81294.59352703199;83040;83900;84325;86261;44085.77957110194;46398.768006160426;47341;57260.71369643125;75348.62325688337;62641.37358626355;64366;64386;64581.03128453077;65757;9363.29775266844;9628.807423851344;9737.951310243403;9782.559784809559;9799.657012004545;44489.55510444854;44923;46292.07415851732;46354;47359.28961065656;59966.400335996084;63650.68174659097;64135;64444;65921.67039164774;11644.475998580254;11692.766144677229;11974.940125299318;11998.340091295062;12362.44369003379;12596.181248218836;12637.368131593199;12793.360331983178;12872.871271287167;13015.284159371326;12313.692157696129;12460.43928023223;12472.376381181086;12513.874861251636;12699.682507937006;11645.243059201124;11783.705407364541;11947.581834635746;11973.221740586834;12275;12046.277223366626;12229.877701222875;12624.74750505003;12735.745285094432;13590.864091359355;10255.282130250811;10278.537465814206;10379.688609341732;10547.52536135891;10611.045005949502;10555.89444105549;10739.751549717075;10903.454827258447;10906.672799816019;10969 08:00:45 INFO - PROCESS | 5688 | __end_tp_report 08:00:45 INFO - PROCESS | 5688 | __start_cc_report 08:00:45 INFO - PROCESS | 5688 | _x_x_mozilla_cycle_collect,1084 08:00:45 INFO - PROCESS | 5688 | __end_cc_report 08:00:45 INFO - PROCESS | 5688 | __startTimestamp1481040045056__endTimestamp 08:00:45 INFO - PROCESS | 5688 | 08:00:45 INFO - PROCESS | 5688 | ------- Summary: start ------- 08:00:45 INFO - PROCESS | 5688 | Number of tests: 6 08:00:45 INFO - PROCESS | 5688 | 08:00:45 INFO - PROCESS | 5688 | [#0] dojo.html Cycles:165 Average:5503.82 Median:5719.26 stddev:615.62 (10.8%) stddev-sans-first:589.58 08:00:45 INFO - PROCESS | 5688 | Values: 3166.9 3169.3 3179.6 3205.2 3210.2 5425.5 5490.0 5501.0 5523.4 5538.1 5523.8 5555.4 5572.8 5574.6 5575.9 5012.9 5023.3 5046.5 5076.4 5094.4 4965.3 4967.5 5004.9 5055.3 5106.8 5034.5 5105.9 5120.2 5140.3 5143.2 5123.8 5124.1 5124.8 5128.6 5165.0 4860.1 4868.5 5035.8 5045.9 5101.6 5423.0 5428.8 5461.2 5489.5 5511.4 5882.0 5897.3 5925.8 5956.7 5971.9 5772.8 5994.6 5997.0 6007.2 6008.5 5449.7 5471.0 5521.0 5559.9 5605.5 6076.5 6080.6 6084.1 6090.8 6097.5 5695.1 5819.8 5831.8 5837.2 5837.9 5816.3 5832.9 5898.0 5901.3 5988.1 5852.0 5899.2 5899.4 5901.5 5903.0 5895.4 5918.7 5929.8 5931.1 5934.6 4479.6 4514.3 4541.3 4566.8 4590.1 4075.0 4077.7 4093.5 4101.7 4107.7 5693.9 5711.9 5712.0 5720.1 5754.5 5719.3 5774.0 5910.5 5987.6 5992.6 5640.9 5716.1 5716.1 5723.8 5742.8 5177.9 5207.5 5219.5 5220.8 5222.4 5953.5 6014.5 6037.9 6143.5 6193.7 5817.4 5892.2 5898.3 5914.3 5934.2 6163.5 6164.4 6167.8 6168.9 6172.9 5540.5 5602.1 5805.0 5811.9 5812.3 5838.3 5841.0 5864.6 5929.9 5967.7 5734.6 5803.9 5826.3 5833.5 5845.1 5624.7 5790.6 5805.4 5808.6 5811.1 5631.3 5696.7 5722.0 5746.3 5779.0 5801.0 5805.7 5830.6 5831.0 5842.8 5549.5 5612.4 5652.4 5696.2 5712.7 08:00:45 INFO - PROCESS | 5688 | 08:00:45 INFO - PROCESS | 5688 | [#1] ext.html Cycles:180 Average:61967.50 Median:21400.20 stddev:119855.75 (560.1%) stddev-sans-first:120103.37 08:00:45 INFO - PROCESS | 5688 | Values: 586.0 612.4 634.9 652.3 673.2 34997.5 35659.1 37642.8 37726.0 37774.4 47589.5 48633.5 48636.5 50840.7 51123.0 8697.0 8848.1 8856.2 8857.6 8865.6 8423.6 8647.5 8783.3 8876.9 10358.2 10486.7 10882.3 10888.2 10891.2 10900.7 10538.0 10631.3 10631.3 10634.0 10635.4 10488.9 10535.9 10547.5 10552.4 10560.5 43769.0 44079.3 44101.3 44113.6 44196.6 3858.0 3884.1 3945.6 4161.9 4447.6 32324.5 32493.5 32785.5 33048.3 33135.5 4460.9 4505.3 4526.2 4547.7 4559.5 353717.0 356370.0 356914.2 357302.0 360352.0 63826.0 63832.4 63945.7 64107.0 64240.0 40129.8 67308.0 67358.0 67449.7 67474.0 18504.9 19182.0 19213.3 19216.7 19219.0 14721.6 14812.2 14817.7 14830.6 14833.8 18442.6 18896.3 19690.2 20973.0 21109.8 7267.7 7371.0 7484.4 7580.6 7640.5 914.9 1121.8 1123.6 1126.7 1127.2 33111.3 33355.3 33642.7 33647.3 34135.5 1125.7 1148.9 1186.7 1211.4 1221.9 17725.0 18218.5 18364.2 18396.8 18459.3 560453.0 563175.0 566868.0 567393.0 567785.0 63235.0 63827.7 63842.4 63944.4 64094.7 1330.6 1384.1 1399.3 1447.7 1451.5 31789.0 34384.5 35183.3 35371.9 35493.3 55446.0 55962.4 55963.4 56011.4 56015.0 407719.0 409956.0 410017.0 410176.0 411014.0 30389.5 32829.7 32833.7 33181.5 33384.7 49282.3 49314.5 49698.8 50420.7 51080.0 42484.6 42623.8 42658.0 43153.6 44017.3 41872.8 41958.8 42740.4 43819.0 44303.8 43368.0 44086.0 44760.1 44835.8 44988.1 35994.6 38421.2 38776.8 38813.6 38916.3 29110.6 29201.7 29382.3 29399.5 29671.3 08:00:45 INFO - PROCESS | 5688 | 08:00:45 INFO - PROCESS | 5688 | [#2] jquery.html Cycles:180 Average:29256.51 Median:24712.07 stddev:78857.95 (319.1%) stddev-sans-first:79049.40 08:00:45 INFO - PROCESS | 5688 | Values: 401.4 414.2 428.0 429.7 431.1 14549.9 16048.8 19453.8 19697.7 20297.4 19579.1 19790.9 19933.3 20106.4 20289.6 5547.8 5670.1 5710.8 5767.8 5855.8 4303.9 4548.0 5643.4 5776.9 5789.2 6011.6 6288.5 6312.7 6397.8 6435.9 6260.4 6431.4 6504.3 6538.3 6540.0 5788.3 5869.5 5876.3 5876.6 5879.8 23630.6 23921.9 24091.4 24476.6 24947.5 2506.5 2596.5 2612.4 2748.6 2884.8 14532.9 14977.2 15109.5 15385.8 15876.0 1942.6 1973.8 1975.7 1984.4 2061.2 55637.0 88269.6 88281.0 89040.0 90254.5 11248.3 11352.5 11412.2 11598.1 11611.8 16676.7 16682.7 16695.4 16719.7 16725.9 8676.2 8707.5 8759.3 8909.4 8966.8 8385.7 8415.1 8417.0 8648.9 8675.5 6938.2 6965.6 7028.8 7087.5 7118.3 1956.8 1996.1 2013.4 2040.0 2041.3 928.2 980.3 981.8 1036.2 1057.0 18971.6 19872.9 20085.4 21431.9 21536.6 1001.7 1017.7 1020.1 1028.8 1071.8 10421.4 11366.5 11470.7 11473.0 11490.8 462586.0 469536.0 469806.0 483923.0 500714.0 83710.6 93512.0 94149.5 99179.5 99228.0 1000.6 1026.8 1052.7 1060.3 1073.5 17914.2 18190.5 18483.0 18671.9 19006.9 42098.0 43000.8 43275.6 43367.8 44637.6 57996.0 59559.7 60998.7 61399.7 62593.4 8522.2 8901.3 8953.6 8955.7 9161.5 11888.0 12934.3 13021.4 13266.8 13377.5 11142.2 11154.9 11256.5 11528.8 11996.5 10975.8 11264.3 11522.1 11668.9 11726.3 10992.5 11532.8 11746.2 11787.6 11855.6 8398.8 8619.0 8675.0 8741.6 8870.6 10517.7 11069.3 11417.8 11873.7 12193.9 08:00:45 INFO - PROCESS | 5688 | 08:00:45 INFO - PROCESS | 5688 | [#3] mootools.html Cycles:180 Average:5845.16 Median:2687.57 stddev:3286.72 (122.3%) stddev-sans-first:3278.52 08:00:45 INFO - PROCESS | 5688 | Values: 1342.9 1506.7 1514.3 1646.2 1790.2 7919.9 8641.3 8916.5 8930.0 9135.5 8850.6 8931.4 8936.6 8937.6 8943.2 2511.5 2540.6 2543.9 2544.7 2545.6 2404.8 2478.9 2482.7 2486.4 2487.5 2422.6 2426.6 2482.7 2487.1 2487.6 2279.9 2286.5 2305.8 2402.2 2406.3 2241.9 2295.7 2296.9 2298.7 2312.2 8776.9 8888.8 8964.6 8994.2 8997.9 5429.6 5623.2 5662.7 5664.6 5687.8 3455.0 3592.2 3656.5 3734.1 3734.4 1205.9 1214.5 1241.4 1294.7 1304.8 12237.0 12383.7 12424.1 12436.3 12449.0 4700.6 4745.0 4814.8 4887.9 4890.3 9955.2 9965.9 9967.8 9982.6 9984.7 5537.6 5615.7 5626.0 5628.6 5631.5 4423.7 4572.8 4726.3 5230.7 5267.8 4045.2 4064.9 4178.9 4179.0 4183.1 1237.5 1283.8 1286.3 1288.6 1300.2 949.7 970.8 974.7 982.9 983.6 5713.5 6106.3 6196.4 6239.5 6360.8 472.4 487.2 496.9 504.2 524.5 4161.5 4179.7 4253.4 4256.0 4285.3 10722.9 10969.4 11018.0 11057.4 11067.3 10978.5 10982.9 10983.7 10988.2 11005.9 7789.9 8108.0 8118.0 8366.5 8464.6 6105.6 6162.3 6246.4 6277.1 6398.0 10058.5 10090.9 10172.0 10221.1 10236.3 9321.2 9540.0 10423.9 10530.1 10530.3 7689.2 7808.0 7871.8 7921.5 8007.9 8516.2 8538.6 8572.1 8576.2 8585.4 7613.0 7677.0 7722.2 7736.5 7765.1 7136.4 7296.6 7470.6 7516.2 7753.4 6794.2 6864.0 6873.9 6874.9 6880.6 4674.8 4701.7 4714.6 4775.5 4790.8 5038.3 5053.5 5165.7 5218.4 5240.6 08:00:45 INFO - PROCESS | 5688 | 08:00:45 INFO - PROCESS | 5688 | [#4] prototype.html Cycles:180 Average:4678.90 Median:5268.45 stddev:1328.66 (25.2%) stddev-sans-first:1292.22 08:00:45 INFO - PROCESS | 5688 | Values: 359.1 361.0 367.1 368.2 371.1 5315.3 5335.0 5335.3 5344.0 5397.1 5296.3 5304.4 5315.4 5319.9 5326.5 4154.2 4183.5 4196.8 4208.7 4221.7 4170.2 4191.1 4198.2 4199.9 4215.3 4157.6 4165.8 4186.1 4190.7 4207.3 4124.9 4196.0 4204.6 4211.7 4226.1 3770.8 3772.7 3777.8 3784.8 3791.8 5120.3 5137.7 5143.8 5161.8 5163.6 4708.6 4759.6 4803.1 4806.8 4806.8 5497.6 5515.4 5516.0 5528.0 5540.3 4128.5 4134.4 4182.9 4185.0 4190.2 5568.0 5656.6 5688.3 5710.3 5716.3 4234.8 4258.1 4262.1 4276.5 4295.2 4321.2 4328.3 4331.4 4338.8 4362.8 4681.7 4814.5 4832.2 4837.9 4841.7 5433.2 5464.2 5508.5 5508.6 5513.8 1425.7 1441.1 1447.3 1464.9 1471.2 987.8 1031.6 1036.0 1043.7 1060.9 5140.8 5146.4 5209.2 5211.5 5215.6 5364.7 5414.6 5436.0 5469.3 5496.9 4950.4 5190.2 5207.7 5208.6 5238.3 2878.6 2888.6 2893.9 2895.0 2911.0 5631.2 5665.7 5687.3 5694.3 5696.2 5209.8 5472.3 5517.4 5525.2 5533.7 5615.0 5773.3 5774.2 5817.2 5868.1 5640.5 5662.2 5682.2 5688.6 5693.5 5274.3 5394.4 5411.0 5488.4 5630.9 5856.0 5865.5 5868.6 5871.7 5888.4 4137.9 4248.6 4268.2 4271.4 4273.9 5625.4 5625.7 5637.5 5671.3 5672.7 5529.7 5564.0 5581.7 5586.5 5595.3 5310.9 5560.8 5564.7 5605.6 5607.4 5568.4 5573.2 5579.0 5585.2 5593.9 5625.9 5658.8 5663.2 5666.9 5683.5 5262.6 5400.9 5516.9 5532.8 5537.7 08:00:45 INFO - PROCESS | 5688 | 08:00:45 INFO - PROCESS | 5688 | [#5] yui.html Cycles:180 Average:17201.23 Median:26031.22 stddev:21883.09 (84.1%) stddev-sans-first:21909.72 08:00:45 INFO - PROCESS | 5688 | Values: 775.5 793.2 802.4 803.8 863.7 16026.7 16188.0 16365.1 16587.2 16822.2 16029.7 16044.8 16047.4 16088.7 16133.9 705.1 832.0 850.6 850.8 851.8 723.6 835.5 853.6 853.7 859.0 904.1 904.1 904.8 906.0 907.6 734.6 889.4 892.8 896.1 897.3 554.2 630.5 646.6 647.7 652.2 15276.9 15278.6 15315.3 15318.3 15323.6 14041.6 14111.9 14249.0 14253.6 14271.5 12457.6 12518.3 12642.4 12669.2 12911.4 4585.2 4620.2 4632.6 4651.7 4764.4 64711.0 66180.7 66580.3 67457.3 67828.3 11160.4 11195.0 11343.6 11389.1 11567.2 20199.2 20279.7 20306.6 20343.6 20519.3 7988.4 8419.8 8567.3 8591.3 8643.3 4721.4 4879.6 4901.5 4955.9 4981.7 3321.0 3419.2 3425.2 3435.5 3436.1 597.3 607.4 610.8 616.2 629.9 597.9 670.9 676.1 679.1 686.1 8885.4 9199.5 9270.4 9390.3 9433.0 644.7 703.9 768.2 790.0 814.6 4345.8 4551.5 4629.7 4668.2 4674.6 81294.6 83040.0 83900.0 84325.0 86261.0 44085.8 46398.8 47341.0 57260.7 75348.6 62641.4 64366.0 64386.0 64581.0 65757.0 9363.3 9628.8 9738.0 9782.6 9799.7 44489.6 44923.0 46292.1 46354.0 47359.3 59966.4 63650.7 64135.0 64444.0 65921.7 11644.5 11692.8 11974.9 11998.3 12362.4 12596.2 12637.4 12793.4 12872.9 13015.3 12313.7 12460.4 12472.4 12513.9 12699.7 11645.2 11783.7 11947.6 11973.2 12275.0 12046.3 12229.9 12624.7 12735.7 13590.9 10255.3 10278.5 10379.7 10547.5 10611.0 10555.9 10739.8 10903.5 10906.7 10969.0 08:00:45 INFO - PROCESS | 5688 | -------- Summary: end -------- 08:00:45 INFO - PROCESS | 5688 | 08:00:45 INFO - TEST-INFO | 5688: exit 0 08:00:45 INFO - TEST-OK | dromaeo_css | took 1115199ms 08:00:45 INFO - TEST-START | kraken 08:00:45 INFO - operating with platform_type : linux_ 08:00:45 INFO - Initialising browser for kraken test... 08:00:45 INFO - TEST-INFO | started process 6006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyO9vXi/profile http://localhost:37331/getInfo.html) 08:00:50 INFO - PROCESS | 6006 | __metrics Screen width/height:1600/1200 08:00:50 INFO - PROCESS | 6006 | colorDepth:24 08:00:50 INFO - PROCESS | 6006 | Browser inner width/height: 1024/697 08:00:50 INFO - PROCESS | 6006 | __metrics 08:00:50 INFO - PROCESS | 6006 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:00:50 INFO - PROCESS | 6006 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:00:51 INFO - PROCESS | 6006 | console.error: PushService: 08:00:51 INFO - PROCESS | 6006 | stateChangeProcessEnqueue: Error transitioning state 08:00:51 INFO - PROCESS | 6006 | UnknownError 08:00:51 INFO - TEST-INFO | 6006: exit 0 08:00:51 INFO - Browser initialized. 08:00:51 INFO - Running cycle 1/1 for kraken test... 08:00:51 INFO - TEST-INFO | started process 6098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyO9vXi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:03 INFO - PROCESS | 6098 | RSS: Main: 145035264 08:01:03 INFO - PROCESS | 6098 | 08:01:06 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37331/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:07 INFO - PROCESS | 6098 | RSS: Main: 186191872 08:01:07 INFO - PROCESS | 6098 | 08:01:09 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37331/tests/kraken/driver.html?testName=audio-dft) 08:01:10 INFO - PROCESS | 6098 | RSS: Main: 175656960 08:01:10 INFO - PROCESS | 6098 | 08:01:13 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37331/tests/kraken/driver.html?testName=audio-fft) 08:01:13 INFO - PROCESS | 6098 | RSS: Main: 266481664 08:01:13 INFO - PROCESS | 6098 | 08:01:15 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37331/tests/kraken/driver.html?testName=audio-oscillator) 08:01:16 INFO - PROCESS | 6098 | RSS: Main: 173178880 08:01:16 INFO - PROCESS | 6098 | 08:01:18 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:19 INFO - PROCESS | 6098 | RSS: Main: 175235072 08:01:19 INFO - PROCESS | 6098 | 08:01:21 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37331/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:22 INFO - PROCESS | 6098 | RSS: Main: 214360064 08:01:22 INFO - PROCESS | 6098 | 08:01:25 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37331/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:26 INFO - PROCESS | 6098 | RSS: Main: 212971520 08:01:26 INFO - PROCESS | 6098 | 08:01:29 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37331/tests/kraken/driver.html?testName=json-parse-financial) 08:01:29 INFO - PROCESS | 6098 | RSS: Main: 211566592 08:01:29 INFO - PROCESS | 6098 | 08:01:31 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:31 INFO - PROCESS | 6098 | RSS: Main: 173772800 08:01:31 INFO - PROCESS | 6098 | 08:01:33 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37331/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:34 INFO - PROCESS | 6098 | RSS: Main: 181493760 08:01:34 INFO - PROCESS | 6098 | 08:01:36 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:36 INFO - PROCESS | 6098 | RSS: Main: 190119936 08:01:36 INFO - PROCESS | 6098 | 08:01:39 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:01:40 INFO - PROCESS | 6098 | RSS: Main: 199954432 08:01:40 INFO - PROCESS | 6098 | 08:01:42 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:01:43 INFO - PROCESS | 6098 | RSS: Main: 195407872 08:01:43 INFO - PROCESS | 6098 | 08:01:44 INFO - PROCESS | 6098 | Cycle 1(1): loaded http://localhost:37331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37331/tests/kraken/driver.html?testName=ai-astar) 08:01:45 INFO - PROCESS | 6098 | RSS: Main: 247525376 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | __start_tp_report 08:01:45 INFO - PROCESS | 6098 | _x_x_mozilla_page_load 08:01:45 INFO - PROCESS | 6098 | _x_x_mozilla_page_load_details 08:01:45 INFO - PROCESS | 6098 | |i|pagename|runs| 08:01:45 INFO - PROCESS | 6098 | |0;ai-astar;105;110;111;113;113;111;113;112;114;112 08:01:45 INFO - PROCESS | 6098 | |1;audio-beat-detection;147;122;123;171;127;127;123;120;151;123 08:01:45 INFO - PROCESS | 6098 | |2;audio-dft;160;161;160;159;159;160;160;161;160;160 08:01:45 INFO - PROCESS | 6098 | |3;audio-fft;74;75;75;109;74;75;76;76;102;74 08:01:45 INFO - PROCESS | 6098 | |4;audio-oscillator;83;81;114;83;82;82;106;82;81;117 08:01:45 INFO - PROCESS | 6098 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;116;116 08:01:45 INFO - PROCESS | 6098 | |6;imaging-darkroom;145;145;146;147;146;146;145;146;146;146 08:01:45 INFO - PROCESS | 6098 | |7;imaging-desaturate;84;84;85;84;85;85;85;85;85;85 08:01:45 INFO - PROCESS | 6098 | |8;json-parse-financial;51;51;51;50;50;51;52;51;51;51 08:01:45 INFO - PROCESS | 6098 | |9;json-stringify-tinderbox;59;60;59;61;60;60;59;60;61;60 08:01:45 INFO - PROCESS | 6098 | |10;stanford-crypto-aes;76;76;77;76;76;83;81;75;74;74 08:01:45 INFO - PROCESS | 6098 | |11;stanford-crypto-ccm;129;127;129;127;125;126;134;134;183;131 08:01:45 INFO - PROCESS | 6098 | |12;stanford-crypto-pbkdf2;154;157;161;156;156;154;158;156;153;155 08:01:45 INFO - PROCESS | 6098 | |13;stanford-crypto-sha256-iterative;67;62;63;63;64;63;63;62;62;62 08:01:45 INFO - PROCESS | 6098 | __end_tp_report 08:01:45 INFO - PROCESS | 6098 | __start_cc_report 08:01:45 INFO - PROCESS | 6098 | _x_x_mozilla_cycle_collect,1625 08:01:45 INFO - PROCESS | 6098 | __end_cc_report 08:01:45 INFO - PROCESS | 6098 | __startTimestamp1481040105179__endTimestamp 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | ------- Summary: start ------- 08:01:45 INFO - PROCESS | 6098 | Number of tests: 14 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:2.55 (2.3%) stddev-sans-first:1.27 08:01:45 INFO - PROCESS | 6098 | Values: 105.0 110.0 111.0 113.0 113.0 111.0 113.0 112.0 114.0 112.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:127.00 stddev:17.08 (13.4%) stddev-sans-first:17.39 08:01:45 INFO - PROCESS | 6098 | Values: 147.0 122.0 123.0 171.0 127.0 127.0 123.0 120.0 151.0 123.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 08:01:45 INFO - PROCESS | 6098 | Values: 160.0 161.0 160.0 159.0 159.0 160.0 160.0 161.0 160.0 160.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:13.04 (17.4%) stddev-sans-first:13.58 08:01:45 INFO - PROCESS | 6098 | Values: 74.0 75.0 75.0 109.0 74.0 75.0 76.0 76.0 102.0 74.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:14.91 (18.2%) stddev-sans-first:15.52 08:01:45 INFO - PROCESS | 6098 | Values: 83.0 81.0 114.0 83.0 82.0 82.0 106.0 82.0 81.0 117.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:01:45 INFO - PROCESS | 6098 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 08:01:45 INFO - PROCESS | 6098 | Values: 145.0 145.0 146.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 08:01:45 INFO - PROCESS | 6098 | Values: 84.0 84.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 85.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 08:01:45 INFO - PROCESS | 6098 | Values: 51.0 51.0 51.0 50.0 50.0 51.0 52.0 51.0 51.0 51.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 08:01:45 INFO - PROCESS | 6098 | Values: 59.0 60.0 59.0 61.0 60.0 60.0 59.0 60.0 61.0 60.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:2.94 (3.9%) stddev-sans-first:3.10 08:01:45 INFO - PROCESS | 6098 | Values: 76.0 76.0 77.0 76.0 76.0 83.0 81.0 75.0 74.0 74.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:130.00 stddev:17.32 (13.3%) stddev-sans-first:18.26 08:01:45 INFO - PROCESS | 6098 | Values: 129.0 127.0 129.0 127.0 125.0 126.0 134.0 134.0 183.0 131.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.00 stddev:2.31 (1.5%) stddev-sans-first:2.33 08:01:45 INFO - PROCESS | 6098 | Values: 154.0 157.0 161.0 156.0 156.0 154.0 158.0 156.0 153.0 155.0 08:01:45 INFO - PROCESS | 6098 | 08:01:45 INFO - PROCESS | 6098 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.52 (2.4%) stddev-sans-first:0.71 08:01:45 INFO - PROCESS | 6098 | Values: 67.0 62.0 63.0 63.0 64.0 63.0 63.0 62.0 62.0 62.0 08:01:45 INFO - PROCESS | 6098 | -------- Summary: end -------- 08:01:45 INFO - PROCESS | 6098 | 08:01:46 INFO - TEST-INFO | 6098: exit 0 08:01:46 INFO - TEST-OK | kraken | took 60342ms 08:01:46 INFO - SUITE-END | took 1175s 08:01:46 INFO - Completed test suite (00:19:35) 08:01:46 INFO - javascript benchmark 08:01:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.9366612667745, 3169.302753394253, 3179.586653735014, 3205.214722393014, 3210.165357007179, 5425.511703946644, 5489.972550137249, 5500.972495137524, 5523.392426833045, 5538.141588053848, 5523.797161215602, 5555.3611334696525, 5572.832815015546, 5574.60977731559, 5575.8606034849145, 5012.874678133039, 5023.32185155003, 5046.470120637336, 5076.390833100033, 5094.439611642735, 4965.3048573199785, 4967.5280848319535, 5004.924926126111, 5055.31753213317, 5106.795728170887, 5034.521720436571, 5105.872353191163, 5120.180771076629, 5140.2546630738525, 5143.202803565453, 5123.846284611468, 5124.0776660201145, 5124.795008199686, 5128.5640720538795, 5165.018646457199, 4860.149473842063, 4868.488808675109, 5035.798568057273, 5045.949540504622, 5101.566366858784, 5423.0, 5428.83713488596, 5461.1808228766, 5489.451054894518, 5511.3937466878615, 5882.0, 5897.262842144732, 5925.792597259076, 5956.672383018932, 5971.880562388771, 5772.826815195551, 5994.610350327215, 5997.040473524259, 6007.15899774032, 6008.48927841134, 5449.700266485342, 5470.987867244572, 5520.972395137998, 5559.861003474864, 5605.495505404533, 6076.5442591805795, 6080.57435979486, 6084.11780291864, 6090.756369745161, 6097.451229389288, 5695.060315048054, 5819.82540523785, 5831.825045248649, 5837.153612726131, 5837.88324233513, 5816.272965879265, 5832.854178645568, 5898.026825573818, 5901.321348044944, 5988.131720900445, 5851.970740146272, 5899.233099697098, 5899.380565040695, 5901.527877769769, 5902.970485147547, 5895.35151133375, 5918.704064796743, 5929.792457263975, 5931.139984702194, 5934.554908381889, 4479.59683628475, 4514.34541991416, 4541.250693635513, 4566.84016059443, 4590.081983603292, 4074.9796251018556, 4077.734947228421, 4093.5292441369625, 4101.651359634405, 4107.732997355162, 5693.914591281134, 5711.8857622848145, 5711.971440142773, 5720.141978703228, 5754.482096611241, 5719.256496655491, 5774.047282198474, 5910.468057874812, 5987.550933679904, 5992.58051936369, 5640.8871822563315, 5716.056850619684, 5716.085426331767, 5723.828285151452, 5742.827715168552, 5177.896442071137, 5207.453217412193, 5219.530242278213, 5220.791168353299, 5222.399424066205, 5953.493953014043, 6014.518838492998, 6037.879242415039, 6143.477804386588, 6193.721282542297, 5817.389174136655, 5892.204552385373, 5898.292204935264, 5914.260717410324, 5934.169216309807, 6163.476104531165, 6164.4143806338325, 6167.753289868355, 6168.938310617016, 6172.876542469216, 5540.501354878081, 5602.1036634138345, 5805.042168042226, 5811.912821307768, 5812.273465816773, 5838.2702162229725, 5841.0, 5864.589478736448, 5929.851753706192, 5967.731452084753, 5734.627249228787, 5803.8549036274435, 5826.329972053099, 5833.504152146946, 5845.064789633639, 5624.746886390204, 5790.594658373873, 5805.3614102447855, 5808.564357673107, 5811.099279611667, 5631.3242410909315, 5696.715164241854, 5721.971390143022, 5746.2529871116485, 5779.0464573344925, 5800.970995144998, 5805.651660900359, 5830.5627077968475, 5830.979578573818, 5842.7662893485485, 5549.500544950974, 5612.438756124355, 5652.434756524314, 5696.202531645656, 5712.65724056558], "value": 5462.601537244209, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.961912475689, 612.4059662127737, 634.8666779976203, 652.3215855510267, 673.1686367336342, 34997.47503787442, 35659.10852228692, 37642.811785941034, 37726.0, 37774.43338349927, 47589.524104758944, 48633.51366486334, 48636.513634863644, 50840.71216795253, 51123.0, 8696.999999999984, 8848.070952549953, 8856.158664926821, 8857.645694172257, 8865.601047952858, 8423.620937057847, 8647.481151130953, 8783.253423459013, 8876.911230887705, 10358.171346292316, 10486.737831554196, 10882.29265097766, 10888.237823352369, 10891.237613367068, 10900.672979810619, 10538.0, 10631.308964917256, 10631.308964917333, 10634.0, 10635.415052172166, 10488.947555262175, 10535.947320263349, 10547.525361358681, 10552.419616921066, 10560.52477638508, 43769.0, 44079.33880991788, 44101.33847992283, 44113.558864411265, 44196.55803441956, 3858.0, 3884.126071633888, 3945.5857135000697, 4161.895952601179, 4447.599716025573, 32324.515132273034, 32493.51259731106, 32785.50821737676, 33048.3390332192, 33135.502967455504, 4460.888477788081, 4505.2791553351635, 4526.23054080807, 4547.681662283609, 4559.498455169929, 353717.0, 356370.0, 356914.2154289238, 357302.0, 360352.0, 63826.0, 63832.36167638264, 63945.680271599274, 64107.0, 64240.036399454046, 40129.79935100306, 67308.0, 67358.0, 67449.65100697959, 67474.0, 18504.907475462536, 19182.0, 19213.32753353626, 19216.71174932377, 19219.0, 14721.55835324942, 14812.185329806749, 14817.70364592702, 14830.629234269014, 14833.777493337608, 18442.63114737698, 18896.338628147947, 19690.21239150418, 20973.0, 21109.788902110784, 7267.672954717051, 7370.96314518424, 7484.401247900155, 7580.583067931317, 7640.465167438226, 914.8993610702818, 1121.8373335866418, 1123.5674265407713, 1126.6649020910247, 1127.1771606727134, 33111.3377732444, 33355.332893342, 33642.66357336444, 33647.32705345928, 34135.48796768051, 1125.6848082536903, 1148.9487119285927, 1186.7329850783506, 1211.3654582702497, 1221.883921027501, 17725.0, 18218.45344639663, 18364.173612187482, 18396.81603183978, 18459.261629534667, 560453.0, 563175.0, 566868.0, 567393.0, 567785.0, 63235.0, 63827.680861596324, 63842.361576384574, 63944.36055639384, 64094.67952660207, 1330.6473784446935, 1384.1141669331637, 1399.2863639543702, 1447.7176950494763, 1451.4702133721116, 31789.0, 34384.48423273703, 35183.29633407369, 35371.93884183479, 35493.29013419769, 55446.0, 55962.440375597354, 55963.44036559582, 56011.43988560225, 56015.0, 407719.0, 409956.0, 410017.0, 410176.0, 411014.0, 30389.544156837223, 32829.671703282664, 32833.67166328402, 33181.50227746634, 33384.666153338156, 49282.26076608782, 49314.50685493243, 49698.75150624224, 50420.74789626028, 51080.0, 42484.575154248065, 42623.786881065396, 42658.0, 43153.56846431496, 44017.339739903284, 41872.79063604662, 41958.790206048776, 42740.358894617224, 43819.0, 44303.778481108675, 43368.0, 44086.0, 44760.10479790321, 44835.77582112199, 44988.100237994404, 35994.64005359913, 38421.231575367776, 38776.80611596924, 38813.611863881, 38916.27324023155, 29110.563341550318, 29201.7079829199, 29382.265443364086, 29399.50332611974, 29671.25821854471], "value": 21416.173403640714, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.41593980758, 414.15099046953736, 427.96148346648806, 429.67559492583104, 431.1205141511317, 14549.854501454982, 16048.839511604894, 19453.805461945394, 19697.704534431996, 20297.39107826764, 19579.118939647713, 19790.90104549479, 19933.3023344183, 20106.396808095782, 20289.59420811583, 5547.805826796063, 5670.121131224657, 5710.800121995731, 5767.769289228426, 5855.765769369242, 4303.935440968388, 4548.044910568785, 5643.4074422185695, 5776.942230577703, 5789.218455508516, 6011.639301641915, 6288.496920246393, 6312.684365781715, 6397.808065758035, 6435.903461448082, 6260.436560709535, 6431.389018043302, 6504.349565043482, 6538.280789113193, 6540.0, 5788.305403351625, 5869.50109240715, 5876.3242227144, 5876.6180198286975, 5879.8236052918055, 23630.64554031691, 23921.88039059811, 24091.39771505709, 24476.632850507256, 24947.50104997908, 2506.52376048552, 2596.5066637338846, 2612.373030472692, 2748.573971034493, 2884.798064135511, 14532.927335363362, 14977.176255305954, 15109.54671359861, 15385.769213461806, 15876.0, 1942.5920556682972, 1973.8124878136555, 1975.6838905775007, 1984.3848406993877, 2061.185831596511, 55637.0, 88269.55865220632, 88281.0, 89040.0, 90254.5487272566, 11248.325100493996, 11352.54589816398, 11412.201145919871, 11598.130140239517, 11611.767764644828, 16676.74984875228, 16682.666346673, 16695.415660451825, 16719.665606688042, 16725.91637041807, 8676.219140277406, 8707.521086340312, 8759.255463285692, 8909.376343656011, 8966.820663586692, 8385.748427547183, 8415.116412776693, 8416.957915210385, 8648.870266946002, 8675.479471231747, 6938.202106757787, 6965.616891071039, 7028.824279392954, 7087.503874728823, 7118.252583478764, 1956.8238858502802, 1996.1217064491577, 2013.4395593979648, 2039.9796002040086, 2041.275347251734, 928.178561972659, 980.2892902645667, 981.842905135175, 1036.160709825029, 1056.99471502642, 18971.620567588572, 19872.90063549673, 20085.39743807688, 21431.89284053601, 21536.56926861454, 1001.7145113642576, 1017.730301470111, 1020.0717347213999, 1028.753099256173, 1071.7642118733866, 10421.374717516821, 11366.545338186379, 11470.655880323604, 11473.024792892531, 11490.770184596262, 462586.0, 469536.0, 469806.0, 483923.0, 500714.0, 83710.58144709238, 93512.0, 94149.5292523533, 99179.50410247903, 99228.0, 1000.5747557288123, 1026.7997740440542, 1052.7420781908481, 1060.3319908457622, 1073.5115522437115, 17914.193861276013, 18190.5452363692, 18483.0, 18671.90664046671, 19006.904965475638, 42098.0, 43000.78499607482, 43275.567244327154, 43367.78316108399, 44637.553624464636, 57996.0, 59559.70220148871, 60998.695006524686, 61399.69300153471, 62593.37406626058, 8522.190391912758, 8901.287896968357, 8953.552322383724, 8955.656651502066, 9161.496117713323, 11888.0, 12934.288614125937, 13021.414036368196, 13266.80099798523, 13377.464901403835, 11142.220044596801, 11154.888451115385, 11256.493457794582, 11528.769424611628, 11996.520139194334, 10975.83536246941, 11264.267822591506, 11522.135839812216, 11668.949794518534, 11726.296422214695, 10992.450377481255, 11532.82700759506, 11746.236494627821, 11787.587434439753, 11855.644330670093, 8398.790030249049, 8619.0, 8675.002374726988, 8741.606627701642, 8870.556472176237, 10517.737056573647, 11069.280496767684, 11417.771644566896, 11873.703157420789, 12193.939030304791], "value": 9686.423594754726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.8992825538076, 1506.6685329227569, 1514.2731488885336, 1646.2098192867422, 1790.221253754616, 7919.920800791991, 8641.308695304377, 8916.46501209928, 8930.017698053218, 9135.451872887632, 8850.601722922467, 8931.37480376374, 8936.553172341373, 8937.642494300237, 8943.239824614899, 2511.5353659572993, 2540.6316084167784, 2543.923682289525, 2544.6564713763682, 2545.643609894616, 2404.831661783676, 2478.938026549342, 2482.726900040994, 2486.3908342456125, 2487.452760392711, 2422.6002709552904, 2426.5996110641813, 2482.726900040994, 2487.141936032066, 2487.5522405966917, 2279.9202027929027, 2286.4855407533337, 2305.8155347572156, 2402.2192787344184, 2406.338256979327, 2241.854279471829, 2295.667128266409, 2296.896639651203, 2298.6666933294578, 2312.190733243368, 8776.912230877673, 8888.822223555557, 8964.551772411354, 8994.235489983359, 8997.865032024525, 5429.592780541436, 5623.240862483553, 5662.745176467069, 5664.631798933056, 5687.800926967578, 3454.9654503454894, 3592.173800026009, 3656.524651795276, 3734.0851491384783, 3734.3838266685966, 1205.921615095016, 1214.5445457953267, 1241.3669028795289, 1294.669859185911, 1304.7586196553668, 12237.0, 12383.690407739788, 12424.130310878241, 12436.253824770632, 12449.0, 4700.637743384482, 4744.976275118672, 4814.759262036884, 4887.926681099786, 4890.315355850184, 9955.153811926068, 9965.850512242323, 9967.750806229757, 9982.550785214682, 9984.650537231308, 5537.612367134262, 5615.719214039282, 5625.987322281947, 5628.634138780966, 5631.521320687787, 4423.734575925455, 4572.8399506017795, 4726.338312636233, 5230.686158830483, 5267.841964741064, 4045.1707399982934, 4064.9187016260103, 4178.8537401191425, 4178.958210417918, 4183.142455796616, 1237.5482948723652, 1283.8202651628778, 1286.3182513267982, 1288.5876519513854, 1300.2263653126374, 949.7150854743687, 970.8203982263304, 974.7222041718077, 982.945937973404, 983.627710311222, 5713.542916566665, 6106.297775755845, 6196.442320191204, 6239.532035097386, 6360.77737279193, 472.43543964962225, 487.2228795071855, 496.86336257528745, 504.2260130699359, 524.5331654827207, 4161.459010328698, 4179.728317659343, 4253.447051883297, 4256.042390462121, 4285.314349704033, 10722.946385268024, 10969.396683182502, 11018.0, 11057.391843448688, 11067.280626759235, 10978.451077446096, 10982.945085274683, 10983.670489885157, 10988.230823842254, 11005.944970275097, 7789.922100778919, 8108.0, 8117.95941020303, 8366.456180348257, 8464.619092140869, 6105.633661980295, 6162.260528736401, 6246.437820596168, 6277.058441233851, 6398.0402939559435, 10058.497075146068, 10090.949545252226, 10172.0, 10221.131203847755, 10236.334638248787, 9321.161095501437, 9539.952300238454, 10423.895761042595, 10530.104941080093, 10530.31552949056, 7689.192634773492, 7807.960960195162, 7871.763847084597, 7921.485103468256, 8007.879881801894, 8516.233538981522, 8538.615762290836, 8572.099929507312, 8576.185262400062, 8585.441946273471, 7612.961935190288, 7677.0, 7722.189170137055, 7736.535807851547, 7765.107012693613, 7136.429085673238, 7296.635168241673, 7470.589117598584, 7516.24837516244, 7753.379729621504, 6794.150731158606, 6864.0, 6873.862522749617, 6874.896876546756, 6880.552764070319, 4674.836380726794, 4701.7414042228, 4714.646401519831, 4775.522447755336, 4790.8323208687525, 5038.319826823332, 5053.494650534917, 5165.715885626327, 5218.373795144607, 5240.554552863049], "value": 4639.465713742007, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.0789624612868, 360.9602943676196, 367.05666437256247, 368.1734506033954, 371.1074864949795, 5315.309009828722, 5335.0, 5335.279737235482, 5343.973280133599, 5397.082495975684, 5296.25852380667, 5304.416514183436, 5315.441878602739, 5319.9202011969855, 5326.493983071602, 4154.210699967004, 4183.477065366829, 4196.832126714928, 4208.747475151486, 4221.662267018631, 4170.228507726065, 4191.140816132701, 4198.20234155511, 4199.853005144821, 4215.3044747616605, 4157.563455837124, 4165.812538435777, 4186.074405773348, 4190.685698572619, 4207.347861081522, 4124.917501649965, 4195.979020104911, 4204.579542045802, 4211.705180637326, 4226.077134903611, 3770.7549009314307, 3772.6604605585353, 3777.7922214278206, 3784.7729136251914, 3791.829367678461, 5120.259111901934, 5137.6660517066275, 5143.794248230066, 5161.81933632321, 5163.586913046947, 4708.552687494683, 4759.61923046159, 4803.135435621587, 4806.774272560509, 4806.831760888352, 5497.5601951843755, 5515.393306736296, 5516.0, 5528.0, 5540.335159780811, 4128.483939507561, 4134.37984302354, 4182.853600123981, 4184.979075104605, 4190.182914331706, 5567.972160139173, 5656.604037717361, 5688.293511946399, 5710.343310519261, 5716.28546431696, 4234.767087810138, 4258.063226090318, 4262.147570485915, 4276.48682158143, 4295.162443323522, 4321.157374312042, 4328.264195086843, 4331.401159304455, 4338.761368124783, 4362.847300344536, 4681.719096854132, 4814.518548145227, 4832.178529649968, 4837.927431088537, 4841.709497430165, 5433.239346491494, 5464.23500709901, 5508.504234618904, 5508.55931525477, 5513.8345849624575, 1425.7433661940743, 1441.1265355038408, 1447.334226255913, 1464.912105273687, 1471.2349578219266, 987.7975015121883, 1031.5925209542188, 1036.0, 1043.6921108273077, 1060.931039482431, 5140.7943682253035, 5146.408163061295, 5209.218617207373, 5211.462618527544, 5215.55667768244, 5364.7049412282695, 5414.593905457106, 5435.972820135953, 5469.2616496772425, 5496.917546236809, 4950.4059512858685, 5190.169572868323, 5207.661502002357, 5208.583313334924, 5238.292830467838, 2878.56821476776, 2888.595596616475, 2893.8697758600915, 2894.956575651367, 2911.0, 5631.211630371751, 5665.745041473144, 5687.345955215121, 5694.320175548223, 5696.177223288508, 5209.765560549784, 5472.330939063624, 5517.393086760453, 5525.231925783711, 5533.671918739554, 5615.017371959891, 5773.278340207474, 5774.249347584787, 5817.214676018768, 5868.149118377897, 5640.492355688008, 5662.235598194356, 5682.176084467812, 5688.634727665248, 5693.459121383462, 5274.340707411574, 5394.352677678547, 5410.97294513525, 5488.38092762628, 5630.943690563206, 5855.970720146372, 5865.533616595851, 5868.559858010752, 5871.706414679164, 5888.440598143169, 4137.8758637240935, 4248.638865696327, 4268.189044081614, 4271.419574757359, 4273.850415235452, 5625.437456254342, 5625.690587017753, 5637.46444087811, 5671.298610416941, 5672.659640421588, 5529.728162522561, 5563.972180139073, 5581.665100093845, 5586.52514536269, 5595.328560572757, 5310.8937821244135, 5560.777568897361, 5564.666120032811, 5605.607607467438, 5607.355154157324, 5568.387477377404, 5573.247611572386, 5578.972105139448, 5585.245991791056, 5593.9440605595055, 5625.915611265917, 5658.773649053992, 5663.235463212413, 5666.914996275142, 5683.516901063291, 5262.552683021986, 5400.9459905400445, 5516.862078448071, 5532.778688852562, 5537.6709589697375], "value": 4268.290672400948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.4959276470294, 793.1513280789555, 802.4062193976459, 803.7548547692955, 863.7408777366788, 16026.67946641068, 16188.028718276897, 16365.099919504422, 16587.17064146794, 16822.15889205538, 16029.679406411893, 16044.75932861008, 16047.35810567576, 16088.678226435464, 16133.919330403362, 705.14677240539, 832.0473058348188, 850.6469815026757, 850.783050322167, 851.8083431227986, 723.5550136665939, 835.5070508400042, 853.5689476814231, 853.6542700206395, 858.9785255368635, 904.0913881549034, 904.1004200820194, 904.7692838326251, 905.9728208153766, 907.5552979040256, 734.6326836581709, 889.3952112563454, 892.8437523433406, 896.0680891872445, 897.3001059173822, 554.2102503931881, 630.5428564290899, 646.647577070493, 647.6632151281354, 652.1717418877998, 15276.923615381851, 15278.618034549114, 15315.31081101353, 15318.310676019495, 15323.616909577238, 14041.64895877601, 14111.929440352733, 14249.0, 14253.572392828231, 14271.500497482642, 12457.626271211788, 12518.311492867888, 12642.431090600852, 12669.239845609292, 12911.418986145645, 4585.174668559658, 4620.19146649335, 4632.606228470584, 4651.720896746206, 4764.356811830393, 64711.0, 66180.66909665421, 66580.3341966579, 67457.32542674559, 67828.3217167827, 11160.386178760245, 11194.993543260189, 11343.602973895873, 11389.088872890148, 11567.248128871597, 20199.192032318835, 20279.69580456265, 20306.593868122556, 20343.593128137356, 20519.281825136048, 7988.360931125496, 8419.789505262417, 8567.314614830799, 8591.269742071869, 8643.30853531716, 4721.433427988663, 4879.585235255043, 4901.534354236342, 4955.925661115086, 4981.651284410056, 3320.9833950830093, 3419.1623052352334, 3425.246445781924, 3435.4503279475166, 3436.1409647588102, 597.2981746447906, 607.3774381259157, 610.8442347201435, 616.2143267334185, 629.8866204083309, 597.8953683105439, 670.872534218497, 676.0569006236371, 679.1341040173818, 686.1046334533382, 8885.378023538291, 9199.540022998823, 9270.44377337362, 9390.295727820305, 9433.0, 644.6969924135649, 703.8557095795452, 768.1511929318023, 789.9881501777478, 814.5601375257295, 4345.761457984459, 4551.544845515422, 4629.7222166669435, 4668.183067963093, 4674.587551087725, 81294.59352703199, 83040.0, 83900.0, 84325.0, 86261.0, 44085.77957110194, 46398.768006160426, 47341.0, 57260.71369643125, 75348.62325688337, 62641.37358626355, 64366.0, 64386.0, 64581.03128453077, 65757.0, 9363.29775266844, 9628.807423851344, 9737.951310243403, 9782.559784809559, 9799.657012004545, 44489.55510444854, 44923.0, 46292.07415851732, 46354.0, 47359.28961065656, 59966.400335996084, 63650.68174659097, 64135.0, 64444.0, 65921.67039164774, 11644.475998580254, 11692.766144677229, 11974.940125299318, 11998.340091295062, 12362.44369003379, 12596.181248218836, 12637.368131593199, 12793.360331983178, 12872.871271287167, 13015.284159371326, 12313.692157696129, 12460.43928023223, 12472.376381181086, 12513.874861251636, 12699.682507937006, 11645.243059201124, 11783.705407364541, 11947.581834635746, 11973.221740586834, 12275.0, 12046.277223366626, 12229.877701222875, 12624.74750505003, 12735.745285094432, 13590.864091359355, 10255.282130250811, 10278.537465814206, 10379.688609341732, 10547.52536135891, 10611.045005949502, 10555.89444105549, 10739.751549717075, 10903.454827258447, 10906.672799816019, 10969.0], "value": 7179.965241975833, "unit": "score"}], "name": "dromaeo_css", "value": 7376.7669040871215, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 111.0, 113.0, 113.0, 111.0, 113.0, 112.0, 114.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 123.0, 171.0, 127.0, 127.0, 123.0, 120.0, 151.0, 123.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 159.0, 159.0, 160.0, 160.0, 161.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 109.0, 74.0, 75.0, 76.0, 76.0, 102.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 114.0, 83.0, 82.0, 82.0, 106.0, 82.0, 81.0, 117.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 50.0, 50.0, 51.0, 52.0, 51.0, 51.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 61.0, 60.0, 60.0, 59.0, 60.0, 61.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 76.0, 76.0, 83.0, 81.0, 75.0, 74.0, 74.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 129.0, 127.0, 125.0, 126.0, 134.0, 134.0, 183.0, 131.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 161.0, 156.0, 156.0, 154.0, 158.0, 156.0, 153.0, 155.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1465.1, "alertThreshold": 2.0}]} 08:01:46 INFO - Return code: 0 08:01:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:01:46 INFO - # TBPL SUCCESS # 08:01:46 INFO - Running post-action listener: _resource_record_post_action 08:01:46 INFO - [mozharness: 2016-12-06 16:01:46.472622Z] Finished run-tests step (success) 08:01:46 INFO - Running post-run listener: _resource_record_post_run 08:01:46 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 371142656; Read time: 12; Write time: 188380 08:01:46 INFO - TinderboxPrint: CPU usage
13.0% 08:01:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:01:46 INFO - TinderboxPrint: I/O write bytes / time
371,142,656 / 188,380 08:01:46 INFO - TinderboxPrint: CPU idle
8,277.8 (87.0%) 08:01:46 INFO - TinderboxPrint: CPU user
1,190.9 (12.5%) 08:01:46 INFO - TinderboxPrint: Swap in / out
0 / 0 08:01:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124059648; Read time: 0; Write time: 64080 08:01:46 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 246185984; Read time: 0; Write time: 124272 08:01:47 INFO - Running post-run listener: _upload_blobber_files 08:01:47 INFO - Blob upload gear active. 08:01:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:01:47 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 08:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:01:47 INFO - (blobuploader) - INFO - Open directory for files ... 08:01:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:01:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:01:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:50 INFO - (blobuploader) - INFO - Done attempting. 08:01:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:01:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:01:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:52 INFO - (blobuploader) - INFO - Done attempting. 08:01:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:01:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:01:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:52 INFO - (blobuploader) - INFO - Done attempting. 08:01:52 INFO - (blobuploader) - INFO - Iteration through files over. 08:01:52 INFO - Return code: 0 08:01:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:01:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:01:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e81b821312c8b2246e2e922d58ea0dc184a2b5a9258906cf10393af7bb1c2a76dd6ca06df25d60413bd6466553e5b7ab29336e27877943291e51e145480fc9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ae4608376b5a6f8b0731da29eac0b86a5a18066eacc87aa3aa149728b588a8c100edad14e54c1d05e472f1a931f74af871a0a44518873a491c767e691cdbd5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/267118b387e95274c39fdb114c61d44c69fa883fdc245d6742d8109125a9e8f5e5143e3b276e574ec28c4ef44dd8808f0759aed3887bd10ba69266df81b8a481"} 08:01:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:01:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:01:52 INFO - Contents: 08:01:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e81b821312c8b2246e2e922d58ea0dc184a2b5a9258906cf10393af7bb1c2a76dd6ca06df25d60413bd6466553e5b7ab29336e27877943291e51e145480fc9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ae4608376b5a6f8b0731da29eac0b86a5a18066eacc87aa3aa149728b588a8c100edad14e54c1d05e472f1a931f74af871a0a44518873a491c767e691cdbd5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/267118b387e95274c39fdb114c61d44c69fa883fdc245d6742d8109125a9e8f5e5143e3b276e574ec28c4ef44dd8808f0759aed3887bd10ba69266df81b8a481"} 08:01:52 INFO - Running post-run listener: copy_logs_to_upload_dir 08:01:52 INFO - Copying logs to upload dir... 08:01:52 INFO - mkdir: /builds/slave/test/build/upload/logs 08:01:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.662393 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-06 08:01:50.364742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-06 08:01:50.368836) ========= 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=d2a8c569965ab8367867b893000001a1-1481020656.893036-420408684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e81b821312c8b2246e2e922d58ea0dc184a2b5a9258906cf10393af7bb1c2a76dd6ca06df25d60413bd6466553e5b7ab29336e27877943291e51e145480fc9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ae4608376b5a6f8b0731da29eac0b86a5a18066eacc87aa3aa149728b588a8c100edad14e54c1d05e472f1a931f74af871a0a44518873a491c767e691cdbd5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/267118b387e95274c39fdb114c61d44c69fa883fdc245d6742d8109125a9e8f5e5143e3b276e574ec28c4ef44dd8808f0759aed3887bd10ba69266df81b8a481"} build_url:https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/EUPiUL-MTxOylHc8DqLBxg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e81b821312c8b2246e2e922d58ea0dc184a2b5a9258906cf10393af7bb1c2a76dd6ca06df25d60413bd6466553e5b7ab29336e27877943291e51e145480fc9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ae4608376b5a6f8b0731da29eac0b86a5a18066eacc87aa3aa149728b588a8c100edad14e54c1d05e472f1a931f74af871a0a44518873a491c767e691cdbd5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/267118b387e95274c39fdb114c61d44c69fa883fdc245d6742d8109125a9e8f5e5143e3b276e574ec28c4ef44dd8808f0759aed3887bd10ba69266df81b8a481"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-06 08:01:50.395907) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 08:01:50.396501) ========= 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=d2a8c569965ab8367867b893000001a1-1481020656.893036-420408684 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 08:01:50.478376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-06 08:01:50.478694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-06 08:01:50.478996) ========= ========= Total master_lag: 0.19 =========