builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1475565867.8 results: success (0) buildid: 20161003213020 builduid: d9825623dde9415f9c2c65997ef5857f revision: 96c39d552134572a439c998a2f9577b6d8652c9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:27.801231) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:27.801815) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:27.802160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:27.816992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:27.817392) ========= 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=523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 00:24:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-10-04 00:24:28 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115949 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:28.079925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:28.080324) ========= 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=523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017499 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:28.111879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:28.112448) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 96c39d552134572a439c998a2f9577b6d8652c9a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 96c39d552134572a439c998a2f9577b6d8652c9a --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=523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 00:24:29,110 truncating revision to first 12 chars 2016-10-04 00:24:29,110 Setting DEBUG logging. 2016-10-04 00:24:29,111 attempt 1/10 2016-10-04 00:24:29,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/96c39d552134?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 00:24:29,417 unpacking tar archive at: fx-team-96c39d552134/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697490 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:28.921292) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:28.921621) ========= script_repo_revision: 96c39d552134572a439c998a2f9577b6d8652c9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:28.922073) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:28.922433) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 00:24:28.933857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-04 00:24:28.934253) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:24:29 INFO - MultiFileLogger online at 20161004 00:24:29 in /builds/slave/test 00:24:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:24:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:24:29 INFO - {'append_to_log': False, 00:24:29 INFO - 'base_work_dir': '/builds/slave/test', 00:24:29 INFO - 'blob_upload_branch': 'Fx-Team', 00:24:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:24:29 INFO - 'branch': 'Fx-Team', 00:24:29 INFO - 'buildbot_json_path': 'buildprops.json', 00:24:29 INFO - 'config_files': ('talos/linux_config.py',), 00:24:29 INFO - 'default_actions': ('clobber', 00:24:29 INFO - 'read-buildbot-config', 00:24:29 INFO - 'download-and-extract', 00:24:29 INFO - 'populate-webroot', 00:24:29 INFO - 'create-virtualenv', 00:24:29 INFO - 'install', 00:24:29 INFO - 'run-tests'), 00:24:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:24:29 INFO - 'download_minidump_stackwalk': True, 00:24:29 INFO - 'download_symbols': 'ondemand', 00:24:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:24:29 INFO - 'tooltool.py': '/tools/tooltool.py', 00:24:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:24:29 INFO - '/tools/misc-python/virtualenv.py')}, 00:24:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:24:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:24:29 INFO - 'installer_path': 'installer.exe', 00:24:29 INFO - 'log_level': 'info', 00:24:29 INFO - 'log_name': 'talos', 00:24:29 INFO - 'log_to_console': True, 00:24:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:24:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:24:29 INFO - 'opt_config_files': (), 00:24:29 INFO - 'pip_index': False, 00:24:29 INFO - 'sps_profile': False, 00:24:29 INFO - 'sps_profile_interval': 0, 00:24:29 INFO - 'suite': 'dromaeojs', 00:24:29 INFO - 'system_bits': '32', 00:24:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:24:29 INFO - 'title': 'talos-linux64-ix-065', 00:24:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:24:29 INFO - 'use_talos_json': True, 00:24:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:24:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:24:29 INFO - 'work_dir': 'build'} 00:24:29 INFO - [mozharness: 2016-10-04 07:24:29.931901Z] Running clobber step. 00:24:29 INFO - Running pre-action listener: _resource_record_pre_action 00:24:29 INFO - Running main action method: clobber 00:24:29 INFO - rmtree: /builds/slave/test/build 00:24:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:24:30 INFO - Running post-action listener: _resource_record_post_action 00:24:30 INFO - [mozharness: 2016-10-04 07:24:30.392401Z] Finished clobber step (success) 00:24:30 INFO - [mozharness: 2016-10-04 07:24:30.392503Z] Running read-buildbot-config step. 00:24:30 INFO - Running pre-action listener: _resource_record_pre_action 00:24:30 INFO - Running main action method: read_buildbot_config 00:24:30 INFO - Using buildbot properties: 00:24:30 INFO - { 00:24:30 INFO - "project": "", 00:24:30 INFO - "product": "firefox", 00:24:30 INFO - "script_repo_revision": "production", 00:24:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:24:30 INFO - "repository": "", 00:24:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:24:30 INFO - "buildid": "20161003213020", 00:24:30 INFO - "pgo_build": "True", 00:24:30 INFO - "basedir": "/builds/slave/test", 00:24:30 INFO - "buildnumber": 498, 00:24:30 INFO - "slavename": "talos-linux64-ix-065", 00:24:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:24:30 INFO - "platform": "ubuntu64_hw", 00:24:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:24:30 INFO - "branch": "fx-team", 00:24:30 INFO - "repo_path": "integration/fx-team", 00:24:30 INFO - "revision": "96c39d552134572a439c998a2f9577b6d8652c9a", 00:24:30 INFO - "stage_platform": "linux64-pgo", 00:24:30 INFO - "builduid": "d9825623dde9415f9c2c65997ef5857f", 00:24:30 INFO - "slavebuilddir": "test" 00:24:30 INFO - } 00:24:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:24:30 INFO - Running post-action listener: _resource_record_post_action 00:24:30 INFO - [mozharness: 2016-10-04 07:24:30.394929Z] Finished read-buildbot-config step (success) 00:24:30 INFO - [mozharness: 2016-10-04 07:24:30.395017Z] Running download-and-extract step. 00:24:30 INFO - Running pre-action listener: _resource_record_pre_action 00:24:30 INFO - Running main action method: download_and_extract 00:24:30 INFO - mkdir: /builds/slave/test/build/tests 00:24:30 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')]} 00:24:30 INFO - trying https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:24:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:24:30 INFO - Downloaded 1361 bytes. 00:24:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:24:30 INFO - Using the following test package requirements: 00:24:30 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:24:30 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:24:30 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:24:30 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:30 INFO - u'jsshell-linux-x86_64.zip'], 00:24:30 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:24:30 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:24:30 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:24:30 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:24:30 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:24:30 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:24:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:24:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:24:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:24:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:24:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:24:31 INFO - Http code: 200 00:24:31 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 00:24:31 INFO - x-amz-cf-id: Er9WLzxlRE7xq4i4nM5NOHNfrfsukGu1C_QkLim8PHpvV2jQiYxbcQ== 00:24:31 INFO - x-amz-version-id: L1qCKMyenaNej0izcjL84e..foQdnu4D 00:24:31 INFO - Expected file size: 21992551 00:24:31 INFO - Obtained file size: 21992551 00:24:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:24:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:24:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:24:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:24:36 INFO - Http code: 200 00:24:36 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 00:24:36 INFO - x-amz-cf-id: xBH__bn4k60-d7w_6AMJPvsgdafo1FYIRHHrZYWnZFHgp0u29o2boQ== 00:24:36 INFO - x-amz-version-id: L1qCKMyenaNej0izcjL84e..foQdnu4D 00:24:36 INFO - Expected file size: 21992551 00:24:36 INFO - Obtained file size: 21992551 00:24:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:24:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:24:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:24:41 INFO - Http code: 200 00:24:41 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 00:24:41 INFO - x-amz-cf-id: DnnrW2JS9KTvPohOXYRB9nObTPfcmzCB0r-iJpnkp3gubNoD-UOXJA== 00:24:41 INFO - x-amz-version-id: ZULjAWfpVw5_NY2UXiyIdNhFocoeAOio 00:24:41 INFO - Expected file size: 14409006 00:24:41 INFO - Obtained file size: 14409006 00:24:41 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')]} 00:24:41 INFO - trying https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:24:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:24:43 INFO - Downloaded 59701648 bytes. 00:24:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:24:43 INFO - mkdir: /builds/slave/test/properties 00:24:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:24:43 INFO - Writing to file /builds/slave/test/properties/build_url 00:24:43 INFO - Contents: 00:24:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:24:43 INFO - Running post-action listener: _resource_record_post_action 00:24:43 INFO - Running post-action listener: set_extra_try_arguments 00:24:43 INFO - [mozharness: 2016-10-04 07:24:43.762497Z] Finished download-and-extract step (success) 00:24:43 INFO - [mozharness: 2016-10-04 07:24:43.762725Z] Running populate-webroot step. 00:24:43 INFO - Running pre-action listener: _resource_record_pre_action 00:24:43 INFO - Running main action method: populate_webroot 00:24:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:24:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:24:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:24:43 INFO - '--tppagecycles', 00:24:43 INFO - '7'], 00:24:43 INFO - 'tests': ['tsvgm']}}, 00:24:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:24:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:24:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:24:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:24:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:43 INFO - 'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:24:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:24:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:43 INFO - 'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['damp', 'tps']}, 00:24:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:43 INFO - 'tests': ['damp', 'tps']}, 00:24:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['dromaeo_dom']}, 00:24:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:24:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['basic_compositor_video']}, 00:24:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:24:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['a11yr', 00:24:43 INFO - 'ts_paint', 00:24:43 INFO - 'tpaint', 00:24:43 INFO - 'sessionrestore', 00:24:43 INFO - 'sessionrestore_no_auto_restore', 00:24:43 INFO - 'tabpaint']}, 00:24:43 INFO - 'other-e10s': {'tests': ['a11yr', 00:24:43 INFO - 'ts_paint', 00:24:43 INFO - 'tpaint', 00:24:43 INFO - 'sessionrestore', 00:24:43 INFO - 'sessionrestore_no_auto_restore', 00:24:43 INFO - 'tabpaint']}, 00:24:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:24:43 INFO - 'ts_paint', 00:24:43 INFO - 'tpaint', 00:24:43 INFO - 'sessionrestore', 00:24:43 INFO - 'sessionrestore_no_auto_restore', 00:24:43 INFO - 'tabpaint']}, 00:24:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:24:43 INFO - 'ts_paint', 00:24:43 INFO - 'tpaint', 00:24:43 INFO - 'sessionrestore', 00:24:43 INFO - 'sessionrestore_no_auto_restore', 00:24:43 INFO - 'tabpaint']}, 00:24:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['a11yr', 00:24:43 INFO - 'ts_paint', 00:24:43 INFO - 'tpaint', 00:24:43 INFO - 'sessionrestore', 00:24:43 INFO - 'sessionrestore_no_auto_restore', 00:24:43 INFO - 'tabpaint']}, 00:24:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['a11yr', 00:24:43 INFO - 'ts_paint', 00:24:43 INFO - 'tpaint', 00:24:43 INFO - 'sessionrestore', 00:24:43 INFO - 'sessionrestore_no_auto_restore', 00:24:43 INFO - 'tabpaint']}, 00:24:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['tsvgx', 00:24:43 INFO - 'tsvgr_opacity', 00:24:43 INFO - 'tart', 00:24:43 INFO - 'tscrollx', 00:24:43 INFO - 'cart']}, 00:24:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:24:43 INFO - 'tsvgr_opacity', 00:24:43 INFO - 'tart', 00:24:43 INFO - 'tscrollx', 00:24:43 INFO - 'cart']}, 00:24:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:43 INFO - 'talos_options': ['--disable-e10s'], 00:24:43 INFO - 'tests': ['tp5o']}, 00:24:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:43 INFO - 'tests': ['tp5o']}, 00:24:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:43 INFO - 'talos_options': ['--disable-e10s', 00:24:43 INFO - '--xperf_path', 00:24:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:24:43 INFO - 'tests': ['tp5n']}, 00:24:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:24:43 INFO - 'talos_options': ['--xperf_path', 00:24:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:24:43 INFO - 'tests': ['tp5n']}}, 00:24:43 INFO - 'talos.zip': {'path': '', 00:24:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:24:43 INFO - Running post-action listener: _resource_record_post_action 00:24:43 INFO - [mozharness: 2016-10-04 07:24:43.784193Z] Finished populate-webroot step (success) 00:24:43 INFO - [mozharness: 2016-10-04 07:24:43.784281Z] Running create-virtualenv step. 00:24:43 INFO - Running pre-action listener: _resource_record_pre_action 00:24:43 INFO - Running main action method: create_virtualenv 00:24:43 INFO - Creating virtualenv /builds/slave/test/build/venv 00:24:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:24:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:24:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:24:43 INFO - Using real prefix '/usr' 00:24:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:24:44 INFO - Installing distribute.............................................................................................................................................................................................done. 00:24:46 INFO - Installing pip.................done. 00:24:46 INFO - Return code: 0 00:24:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:24:46 INFO - Reading from file tmpfile_stdout 00:24:46 INFO - Output received: 00:24:46 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) 00:24:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:24: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')]} 00:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24: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')]} 00:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:46 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:24:46 INFO - Using env: {'DISPLAY': ':0', 00:24:46 INFO - 'HOME': '/home/cltbld', 00:24:46 INFO - 'LANG': 'en_US.UTF-8', 00:24:46 INFO - 'LANGUAGE': 'en_US:en', 00:24:46 INFO - 'LOGNAME': 'cltbld', 00:24:46 INFO - 'MAIL': '/var/mail/cltbld', 00:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:46 INFO - 'MOZ_NO_REMOTE': '1', 00:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:46 INFO - 'NO_EM_RESTART': '1', 00:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:46 INFO - 'PWD': '/builds/slave/test', 00:24:46 INFO - 'SHELL': '/bin/bash', 00:24:46 INFO - 'SHLVL': '1', 00:24:46 INFO - 'TERM': 'linux', 00:24:46 INFO - 'TMOUT': '86400', 00:24:46 INFO - 'USER': 'cltbld', 00:24:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:46 INFO - '_': '/tools/buildbot/bin/python'} 00:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:24:46 INFO - Cleaning up... 00:24:46 INFO - Return code: 0 00:24:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:24: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')]} 00:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24: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')]} 00:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:46 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:24:46 INFO - Using env: {'DISPLAY': ':0', 00:24:46 INFO - 'HOME': '/home/cltbld', 00:24:46 INFO - 'LANG': 'en_US.UTF-8', 00:24:46 INFO - 'LANGUAGE': 'en_US:en', 00:24:46 INFO - 'LOGNAME': 'cltbld', 00:24:46 INFO - 'MAIL': '/var/mail/cltbld', 00:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:46 INFO - 'MOZ_NO_REMOTE': '1', 00:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:46 INFO - 'NO_EM_RESTART': '1', 00:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:46 INFO - 'PWD': '/builds/slave/test', 00:24:46 INFO - 'SHELL': '/bin/bash', 00:24:46 INFO - 'SHLVL': '1', 00:24:46 INFO - 'TERM': 'linux', 00:24:46 INFO - 'TMOUT': '86400', 00:24:46 INFO - 'USER': 'cltbld', 00:24:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:46 INFO - '_': '/tools/buildbot/bin/python'} 00:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:47 INFO - Downloading/unpacking psutil>=3.1.1 00:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:24:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:24:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:24:49 INFO - Installing collected packages: psutil 00:24:49 INFO - Running setup.py install for psutil 00:24:49 INFO - building 'psutil._psutil_linux' extension 00:24:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:24:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:24:49 INFO - building 'psutil._psutil_posix' extension 00:24:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:24:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:24:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:24:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:24:49 INFO - Successfully installed psutil 00:24:49 INFO - Cleaning up... 00:24:49 INFO - Return code: 0 00:24:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:24: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')]} 00:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24: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')]} 00:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:49 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:24:49 INFO - Using env: {'DISPLAY': ':0', 00:24:49 INFO - 'HOME': '/home/cltbld', 00:24:49 INFO - 'LANG': 'en_US.UTF-8', 00:24:49 INFO - 'LANGUAGE': 'en_US:en', 00:24:49 INFO - 'LOGNAME': 'cltbld', 00:24:49 INFO - 'MAIL': '/var/mail/cltbld', 00:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:49 INFO - 'MOZ_NO_REMOTE': '1', 00:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:49 INFO - 'NO_EM_RESTART': '1', 00:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:49 INFO - 'PWD': '/builds/slave/test', 00:24:49 INFO - 'SHELL': '/bin/bash', 00:24:49 INFO - 'SHLVL': '1', 00:24:49 INFO - 'TERM': 'linux', 00:24:49 INFO - 'TMOUT': '86400', 00:24:49 INFO - 'USER': 'cltbld', 00:24:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:49 INFO - '_': '/tools/buildbot/bin/python'} 00:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:24:51 INFO - Installing collected packages: mozsystemmonitor 00:24:51 INFO - Running setup.py install for mozsystemmonitor 00:24:51 INFO - Successfully installed mozsystemmonitor 00:24:51 INFO - Cleaning up... 00:24:52 INFO - Return code: 0 00:24:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:24:52 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')]} 00:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:52 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')]} 00:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:52 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:24:52 INFO - Using env: {'DISPLAY': ':0', 00:24:52 INFO - 'HOME': '/home/cltbld', 00:24:52 INFO - 'LANG': 'en_US.UTF-8', 00:24:52 INFO - 'LANGUAGE': 'en_US:en', 00:24:52 INFO - 'LOGNAME': 'cltbld', 00:24:52 INFO - 'MAIL': '/var/mail/cltbld', 00:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:52 INFO - 'MOZ_NO_REMOTE': '1', 00:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:52 INFO - 'NO_EM_RESTART': '1', 00:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:52 INFO - 'PWD': '/builds/slave/test', 00:24:52 INFO - 'SHELL': '/bin/bash', 00:24:52 INFO - 'SHLVL': '1', 00:24:52 INFO - 'TERM': 'linux', 00:24:52 INFO - 'TMOUT': '86400', 00:24:52 INFO - 'USER': 'cltbld', 00:24:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:52 INFO - '_': '/tools/buildbot/bin/python'} 00:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:52 INFO - Downloading/unpacking jsonschema==2.5.1 00:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:24:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:54 INFO - Downloading functools32-3.2.3-2.tar.gz 00:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:24:54 INFO - warning: no files found matching '*.txt' 00:24:54 INFO - no previously-included directories found matching 'build' 00:24:54 INFO - no previously-included directories found matching 'dist' 00:24:54 INFO - no previously-included directories found matching '.git*' 00:24:54 INFO - Installing collected packages: jsonschema, functools32 00:24:54 INFO - Running setup.py install for functools32 00:24:54 INFO - warning: no files found matching '*.txt' 00:24:54 INFO - no previously-included directories found matching 'build' 00:24:54 INFO - no previously-included directories found matching 'dist' 00:24:54 INFO - no previously-included directories found matching '.git*' 00:24:54 INFO - Successfully installed jsonschema functools32 00:24:54 INFO - Cleaning up... 00:24:54 INFO - Return code: 0 00:24:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:24:54 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')]} 00:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:54 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')]} 00:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:54 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:24:54 INFO - Using env: {'DISPLAY': ':0', 00:24:54 INFO - 'HOME': '/home/cltbld', 00:24:54 INFO - 'LANG': 'en_US.UTF-8', 00:24:54 INFO - 'LANGUAGE': 'en_US:en', 00:24:54 INFO - 'LOGNAME': 'cltbld', 00:24:54 INFO - 'MAIL': '/var/mail/cltbld', 00:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:54 INFO - 'MOZ_NO_REMOTE': '1', 00:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:54 INFO - 'NO_EM_RESTART': '1', 00:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:54 INFO - 'PWD': '/builds/slave/test', 00:24:54 INFO - 'SHELL': '/bin/bash', 00:24:54 INFO - 'SHLVL': '1', 00:24:54 INFO - 'TERM': 'linux', 00:24:54 INFO - 'TMOUT': '86400', 00:24:54 INFO - 'USER': 'cltbld', 00:24:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:54 INFO - '_': '/tools/buildbot/bin/python'} 00:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:24:54 INFO - Cleaning up... 00:24:54 INFO - Return code: 0 00:24:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:24:54 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')]} 00:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:54 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')]} 00:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:54 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:24:54 INFO - Using env: {'DISPLAY': ':0', 00:24:54 INFO - 'HOME': '/home/cltbld', 00:24:54 INFO - 'LANG': 'en_US.UTF-8', 00:24:54 INFO - 'LANGUAGE': 'en_US:en', 00:24:54 INFO - 'LOGNAME': 'cltbld', 00:24:54 INFO - 'MAIL': '/var/mail/cltbld', 00:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:54 INFO - 'MOZ_NO_REMOTE': '1', 00:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:54 INFO - 'NO_EM_RESTART': '1', 00:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:54 INFO - 'PWD': '/builds/slave/test', 00:24:54 INFO - 'SHELL': '/bin/bash', 00:24:54 INFO - 'SHLVL': '1', 00:24:54 INFO - 'TERM': 'linux', 00:24:54 INFO - 'TMOUT': '86400', 00:24:54 INFO - 'USER': 'cltbld', 00:24:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:54 INFO - '_': '/tools/buildbot/bin/python'} 00:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:55 INFO - Downloading/unpacking blobuploader==1.2.4 00:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:56 INFO - Downloading blobuploader-1.2.4.tar.gz 00:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:24:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:24:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:24:57 INFO - Downloading docopt-0.6.1.tar.gz 00:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:24:57 INFO - Installing collected packages: blobuploader, requests, docopt 00:24:57 INFO - Running setup.py install for blobuploader 00:24:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:24:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:24:57 INFO - Running setup.py install for requests 00:24:58 INFO - Running setup.py install for docopt 00:24:58 INFO - Successfully installed blobuploader requests docopt 00:24:58 INFO - Cleaning up... 00:24:58 INFO - Return code: 0 00:24:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:24:58 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:24:58 INFO - Using env: {'DISPLAY': ':0', 00:24:58 INFO - 'HOME': '/home/cltbld', 00:24:58 INFO - 'LANG': 'en_US.UTF-8', 00:24:58 INFO - 'LANGUAGE': 'en_US:en', 00:24:58 INFO - 'LOGNAME': 'cltbld', 00:24:58 INFO - 'MAIL': '/var/mail/cltbld', 00:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:58 INFO - 'MOZ_NO_REMOTE': '1', 00:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:24:58 INFO - 'NO_EM_RESTART': '1', 00:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:58 INFO - 'PWD': '/builds/slave/test', 00:24:58 INFO - 'SHELL': '/bin/bash', 00:24:58 INFO - 'SHLVL': '1', 00:24:58 INFO - 'TERM': 'linux', 00:24:58 INFO - 'TMOUT': '86400', 00:24:58 INFO - 'USER': 'cltbld', 00:24:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:58 INFO - '_': '/tools/buildbot/bin/python'} 00:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:24:58 INFO - Running setup.py (path:/tmp/pip-I1jzeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:24:58 INFO - Running setup.py (path:/tmp/pip-X0TtSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:24:58 INFO - Running setup.py (path:/tmp/pip-JlLkd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:24:58 INFO - Running setup.py (path:/tmp/pip-Q9LD2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:24:58 INFO - Running setup.py (path:/tmp/pip-Z_Hn1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:24:58 INFO - Running setup.py (path:/tmp/pip-UcWFJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:24:58 INFO - Running setup.py (path:/tmp/pip-VjnG9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:24:59 INFO - Running setup.py (path:/tmp/pip-aDgU7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:24:59 INFO - Running setup.py (path:/tmp/pip-KigMrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:24:59 INFO - Running setup.py (path:/tmp/pip-MgPm7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:24:59 INFO - Running setup.py (path:/tmp/pip-ZxM9Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:24:59 INFO - Running setup.py (path:/tmp/pip-h2jbnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:24:59 INFO - Running setup.py (path:/tmp/pip-o9nyBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:24:59 INFO - Running setup.py (path:/tmp/pip-WgLu7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:24:59 INFO - Running setup.py (path:/tmp/pip-rpKeyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:24:59 INFO - Running setup.py (path:/tmp/pip-PYUgIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:24:59 INFO - Running setup.py (path:/tmp/pip-hRTfNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:24:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:24:59 INFO - Running setup.py install for manifestparser 00:24:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:24:59 INFO - Running setup.py install for mozcrash 00:24:59 INFO - Running setup.py install for mozdebug 00:25:00 INFO - Running setup.py install for mozdevice 00:25:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Running setup.py install for mozfile 00:25:00 INFO - Running setup.py install for mozhttpd 00:25:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Running setup.py install for mozinfo 00:25:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Running setup.py install for mozInstall 00:25:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Running setup.py install for mozleak 00:25:00 INFO - Running setup.py install for mozlog 00:25:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Running setup.py install for moznetwork 00:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:25:00 INFO - Running setup.py install for mozprocess 00:25:00 INFO - Running setup.py install for mozprofile 00:25:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:25:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:25:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:25:01 INFO - Running setup.py install for mozrunner 00:25:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:25:01 INFO - Running setup.py install for mozscreenshot 00:25:01 INFO - Running setup.py install for moztest 00:25:01 INFO - Running setup.py install for mozversion 00:25:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:25:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:25:01 INFO - Cleaning up... 00:25:01 INFO - Return code: 0 00:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:01 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:25:01 INFO - Using env: {'DISPLAY': ':0', 00:25:01 INFO - 'HOME': '/home/cltbld', 00:25:01 INFO - 'LANG': 'en_US.UTF-8', 00:25:01 INFO - 'LANGUAGE': 'en_US:en', 00:25:01 INFO - 'LOGNAME': 'cltbld', 00:25:01 INFO - 'MAIL': '/var/mail/cltbld', 00:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:01 INFO - 'MOZ_NO_REMOTE': '1', 00:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:25:01 INFO - 'NO_EM_RESTART': '1', 00:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:01 INFO - 'PWD': '/builds/slave/test', 00:25:01 INFO - 'SHELL': '/bin/bash', 00:25:01 INFO - 'SHLVL': '1', 00:25:01 INFO - 'TERM': 'linux', 00:25:01 INFO - 'TMOUT': '86400', 00:25:01 INFO - 'USER': 'cltbld', 00:25:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:01 INFO - '_': '/tools/buildbot/bin/python'} 00:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:25:01 INFO - Running setup.py (path:/tmp/pip-M0P1KA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:25:01 INFO - Running setup.py (path:/tmp/pip-uTAet4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:25:01 INFO - Running setup.py (path:/tmp/pip-0Jkagr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:25:01 INFO - Running setup.py (path:/tmp/pip-JvuOPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:25:02 INFO - Running setup.py (path:/tmp/pip-MklpGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:25:02 INFO - Running setup.py (path:/tmp/pip-VZcmYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:25:02 INFO - Running setup.py (path:/tmp/pip-HBYVt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:25:02 INFO - Running setup.py (path:/tmp/pip-5s3NIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:25:02 INFO - Running setup.py (path:/tmp/pip-9RNzyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:25:02 INFO - Running setup.py (path:/tmp/pip-rO5Awb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:25:02 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)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:25:02 INFO - Running setup.py (path:/tmp/pip-_oTnVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:25:02 INFO - Running setup.py (path:/tmp/pip-YLKg2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:25:02 INFO - Running setup.py (path:/tmp/pip-PbGF6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:25:02 INFO - Running setup.py (path:/tmp/pip-u3Ubpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:02 INFO - Running setup.py (path:/tmp/pip-js91n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:25:02 INFO - Running setup.py (path:/tmp/pip-QoLLL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:25:02 INFO - Running setup.py (path:/tmp/pip-hbyaLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:25:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:04 INFO - Downloading blessings-1.6.tar.gz 00:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:25:04 INFO - Installing collected packages: blessings 00:25:04 INFO - Running setup.py install for blessings 00:25:05 INFO - Successfully installed blessings 00:25:05 INFO - Cleaning up... 00:25:05 INFO - Return code: 0 00:25:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:25:05 INFO - Reading from file tmpfile_stdout 00:25:05 INFO - Current package versions: 00:25:05 INFO - argparse == 1.2.1 00:25:05 INFO - blessings == 1.6 00:25:05 INFO - blobuploader == 1.2.4 00:25:05 INFO - docopt == 0.6.1 00:25:05 INFO - functools32 == 3.2.3-2 00:25:05 INFO - jsonschema == 2.5.1 00:25:05 INFO - manifestparser == 1.1 00:25:05 INFO - mozInstall == 1.12 00:25:05 INFO - mozcrash == 0.17 00:25:05 INFO - mozdebug == 0.1 00:25:05 INFO - mozdevice == 0.48 00:25:05 INFO - mozfile == 1.2 00:25:05 INFO - mozhttpd == 0.7 00:25:05 INFO - mozinfo == 0.9 00:25:05 INFO - mozleak == 0.1 00:25:05 INFO - mozlog == 3.4 00:25:05 INFO - moznetwork == 0.27 00:25:05 INFO - mozprocess == 0.23 00:25:05 INFO - mozprofile == 0.28 00:25:05 INFO - mozrunner == 6.12 00:25:05 INFO - mozscreenshot == 0.1 00:25:05 INFO - mozsystemmonitor == 0.3 00:25:05 INFO - moztest == 0.7 00:25:05 INFO - mozversion == 1.4 00:25:05 INFO - psutil == 3.1.1 00:25:05 INFO - requests == 1.2.3 00:25:05 INFO - wsgiref == 0.1.2 00:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:25:05 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')]} 00:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:05 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')]} 00:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:05 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:25:05 INFO - Using env: {'DISPLAY': ':0', 00:25:05 INFO - 'HOME': '/home/cltbld', 00:25:05 INFO - 'LANG': 'en_US.UTF-8', 00:25:05 INFO - 'LANGUAGE': 'en_US:en', 00:25:05 INFO - 'LOGNAME': 'cltbld', 00:25:05 INFO - 'MAIL': '/var/mail/cltbld', 00:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:05 INFO - 'MOZ_NO_REMOTE': '1', 00:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:25:05 INFO - 'NO_EM_RESTART': '1', 00:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:05 INFO - 'PWD': '/builds/slave/test', 00:25:05 INFO - 'SHELL': '/bin/bash', 00:25:05 INFO - 'SHLVL': '1', 00:25:05 INFO - 'TERM': 'linux', 00:25:05 INFO - 'TMOUT': '86400', 00:25:05 INFO - 'USER': 'cltbld', 00:25:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:05 INFO - '_': '/tools/buildbot/bin/python'} 00:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:25:05 INFO - Cleaning up... 00:25:05 INFO - Return code: 0 00:25:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:25:05 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')]} 00:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:05 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')]} 00:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:05 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 0x7ff091031f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, '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': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:25:05 INFO - Using env: {'DISPLAY': ':0', 00:25:05 INFO - 'HOME': '/home/cltbld', 00:25:05 INFO - 'LANG': 'en_US.UTF-8', 00:25:05 INFO - 'LANGUAGE': 'en_US:en', 00:25:05 INFO - 'LOGNAME': 'cltbld', 00:25:05 INFO - 'MAIL': '/var/mail/cltbld', 00:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:05 INFO - 'MOZ_NO_REMOTE': '1', 00:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:25:05 INFO - 'NO_EM_RESTART': '1', 00:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:05 INFO - 'PWD': '/builds/slave/test', 00:25:05 INFO - 'SHELL': '/bin/bash', 00:25:05 INFO - 'SHLVL': '1', 00:25:05 INFO - 'TERM': 'linux', 00:25:05 INFO - 'TMOUT': '86400', 00:25:05 INFO - 'USER': 'cltbld', 00:25:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:05 INFO - '_': '/tools/buildbot/bin/python'} 00:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:25:05 INFO - Cleaning up... 00:25:05 INFO - Return code: 0 00:25:05 INFO - Running post-action listener: _resource_record_post_action 00:25:05 INFO - Running post-action listener: _start_resource_monitoring 00:25:05 INFO - Starting resource monitoring. 00:25:05 INFO - [mozharness: 2016-10-04 07:25:05.871276Z] Finished create-virtualenv step (success) 00:25:05 INFO - [mozharness: 2016-10-04 07:25:05.871861Z] Running install step. 00:25:05 INFO - Running pre-action listener: _resource_record_pre_action 00:25:05 INFO - Running main action method: install 00:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:25:06 INFO - Reading from file tmpfile_stdout 00:25:06 INFO - Detecting whether we're running mozinstall >=1.0... 00:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:25:06 INFO - Reading from file tmpfile_stdout 00:25:06 INFO - Output received: 00:25:06 INFO - Usage: mozinstall [options] installer 00:25:06 INFO - Options: 00:25:06 INFO - -h, --help show this help message and exit 00:25:06 INFO - -d DEST, --destination=DEST 00:25:06 INFO - Directory to install application into. [default: 00:25:06 INFO - "/builds/slave/test"] 00:25:06 INFO - --app=APP Application being installed. [default: firefox] 00:25:06 INFO - mkdir: /builds/slave/test/build/application 00:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:25:23 INFO - Reading from file tmpfile_stdout 00:25:23 INFO - Output received: 00:25:23 INFO - /builds/slave/test/build/application/firefox/firefox 00:25:23 INFO - Running post-action listener: _resource_record_post_action 00:25:23 INFO - [mozharness: 2016-10-04 07:25:23.181469Z] Finished install step (success) 00:25:23 INFO - [mozharness: 2016-10-04 07:25:23.181719Z] Running run-tests step. 00:25:23 INFO - Running pre-action listener: _resource_record_pre_action 00:25:23 INFO - Running main action method: run_tests 00:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:25:23 INFO - Python 2.7.3 00:25:23 INFO - Return code: 0 00:25:23 INFO - grabbing minidump binary from tooltool 00:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:25:23 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 0x1587790>, '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 0x1588690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1588b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:25:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:25:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:25:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:25:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:25:23 INFO - Return code: 0 00:25:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:25:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:25:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:25:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:25:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:25:23 INFO - Using env: {'DISPLAY': ':0', 00:25:23 INFO - 'HOME': '/home/cltbld', 00:25:23 INFO - 'LANG': 'en_US.UTF-8', 00:25:23 INFO - 'LANGUAGE': 'en_US:en', 00:25:23 INFO - 'LOGNAME': 'cltbld', 00:25:23 INFO - 'MAIL': '/var/mail/cltbld', 00:25:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:25:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:23 INFO - 'MOZ_NO_REMOTE': '1', 00:25:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:25:23 INFO - 'NO_EM_RESTART': '1', 00:25:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:23 INFO - 'PWD': '/builds/slave/test', 00:25:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:25:23 INFO - 'SHELL': '/bin/bash', 00:25:23 INFO - 'SHLVL': '1', 00:25:23 INFO - 'TERM': 'linux', 00:25:23 INFO - 'TMOUT': '86400', 00:25:23 INFO - 'USER': 'cltbld', 00:25:23 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483', 00:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:23 INFO - '_': '/tools/buildbot/bin/python'} 00:25:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:25:23 INFO - mozversion application_buildid: 20161003213020 00:25:23 INFO - mozversion application_changeset: 96c39d552134572a439c998a2f9577b6d8652c9a 00:25:23 INFO - mozversion application_display_name: Nightly 00:25:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:25:23 INFO - mozversion application_name: Firefox 00:25:23 INFO - mozversion application_remotingname: firefox 00:25:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:25:23 INFO - mozversion application_vendor: Mozilla 00:25:23 INFO - mozversion application_version: 52.0a1 00:25:23 INFO - mozversion platform_buildid: 20161003213020 00:25:23 INFO - mozversion platform_changeset: 96c39d552134572a439c998a2f9577b6d8652c9a 00:25:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:25:23 INFO - mozversion platform_version: 52.0a1 00:25:23 INFO - using testdate: 1475565923 00:25:23 INFO - actual date: 1475565923 00:25:23 INFO - starting webserver on 'localhost:54512' 00:25:23 INFO - SUITE-START | Running 2 tests 00:25:23 INFO - TEST-START | dromaeo_css 00:25:23 INFO - operating with platform_type : linux_ 00:25:23 INFO - Initialising browser for dromaeo_css test... 00:25:23 INFO - TEST-INFO | started process 28630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUBUpfn/profile http://localhost:54512/getInfo.html) 00:25:27 INFO - PROCESS | 28630 | __metrics Screen width/height:1600/1200 00:25:27 INFO - PROCESS | 28630 | colorDepth:24 00:25:27 INFO - PROCESS | 28630 | Browser inner width/height: 1024/697 00:25:27 INFO - PROCESS | 28630 | __metrics 00:25:28 INFO - PROCESS | 28630 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:25:28 INFO - PROCESS | 28630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:25:29 INFO - PROCESS | 28630 | console.error: PushService: 00:25:29 INFO - PROCESS | 28630 | stateChangeProcessEnqueue: Error transitioning state 00:25:29 INFO - PROCESS | 28630 | UnknownError 00:25:29 INFO - TEST-INFO | 28630: exit 0 00:25:29 INFO - Browser initialized. 00:25:29 INFO - Running cycle 1/1 for dromaeo_css test... 00:25:29 INFO - TEST-INFO | started process 28715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUBUpfn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:25:41 INFO - PROCESS | 28715 | RSS: Main: 174190592 00:25:41 INFO - PROCESS | 28715 | 00:26:33 INFO - PROCESS | 28715 | 1475565993030 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:28:43 INFO - PROCESS | 28715 | Cycle 1(1): loaded http://localhost:54512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54512/tests/dromaeo/cssquery-ext.html) 00:28:44 INFO - PROCESS | 28715 | RSS: Main: 300650496 00:28:44 INFO - PROCESS | 28715 | 00:31:47 INFO - PROCESS | 28715 | Cycle 1(1): loaded http://localhost:54512/tests/dromaeo/cssquery-ext.html (next: http://localhost:54512/tests/dromaeo/cssquery-jquery.html) 00:31:47 INFO - PROCESS | 28715 | RSS: Main: 279982080 00:31:47 INFO - PROCESS | 28715 | 00:34:49 INFO - PROCESS | 28715 | Cycle 1(1): loaded http://localhost:54512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54512/tests/dromaeo/cssquery-mootools.html) 00:34:50 INFO - PROCESS | 28715 | RSS: Main: 219402240 00:34:50 INFO - PROCESS | 28715 | 00:37:52 INFO - PROCESS | 28715 | Cycle 1(1): loaded http://localhost:54512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54512/tests/dromaeo/cssquery-prototype.html) 00:37:53 INFO - PROCESS | 28715 | RSS: Main: 260571136 00:37:53 INFO - PROCESS | 28715 | 00:40:55 INFO - PROCESS | 28715 | Cycle 1(1): loaded http://localhost:54512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54512/tests/dromaeo/cssquery-yui.html) 00:40:56 INFO - PROCESS | 28715 | RSS: Main: 218963968 00:40:56 INFO - PROCESS | 28715 | 00:43:59 INFO - PROCESS | 28715 | Cycle 1(1): loaded http://localhost:54512/tests/dromaeo/cssquery-yui.html (next: http://localhost:54512/tests/dromaeo/cssquery-dojo.html) 00:43:59 INFO - PROCESS | 28715 | RSS: Main: 296353792 00:43:59 INFO - PROCESS | 28715 | 00:43:59 INFO - PROCESS | 28715 | __start_tp_report 00:43:59 INFO - PROCESS | 28715 | _x_x_mozilla_page_load 00:43:59 INFO - PROCESS | 28715 | _x_x_mozilla_page_load_details 00:43:59 INFO - PROCESS | 28715 | |i|pagename|runs| 00:43:59 INFO - PROCESS | 28715 | |0;dojo.html;2956.2313798412415;3012.939741205176;3013.6082309299773;3038.9696103038964;3062.6477955035166;5138.126518491856;5144.948550514503;5205.687658740479;5213.8696532586655;5230.764615592293;5235.1885457754015;5257.947420525794;5323.467653234675;5330.040592693314;5375.946240537593;4738.691985020962;4793.90412191756;4829.686070405422;4843;4850.054239423313;4786.186348320776;4798.0643774464;4805.951940480585;4826.613870890338;4870.4885986971385;4819.156647586676;4840.903181936359;4844.224924012141;4895.608351331903;4903.141950158726;4669.976650116728;4701.036287561042;4744.691595046345;4817.445993710733;4862.635302352338;4716.174669432869;4727.479977202505;4731.621470282369;4786.425628924517;4808.735519546423;5143.3570803649545;5187.0922588546855;5194.857091479446;5198.090334191501;5198.220266959948;5412.756425960802;5467.617266791326;5554.0835762099205;5562.332520097614;5567.164925261202;5482.80810171646;5531;5534.640248383883;5579.609427340088;5646.378898321182;5199.168133098686;5201.921971170435;5204.479552044765;5204.557612602971;5205.765740541685;5527.2538207342295;5655.491005809415;5666.065099258659;5668.489835914787;5721.485066344049;5369.892602147936;5427.755750991215;5470.945290547043;5477.096279113902;5560.860978475571;5515.4760297771645;5543.944560554423;5544.750486228129;5556.91664625031;5560;5506.476884695948;5541.5289700375115;5556.499915007668;5561.610687251854;5616.747246373841;5329.440408757102;5380.977614253279;5421.756020979065;5508;5509.953108909374;4320.2223599751715;4324.524302326741;4335.111302183045;4375.693701440869;4379.1022840317655;3831.578526362098;3849.576546579874;3852.036990752312;3894.299026175259;3895.668868146183;5165.483451654804;5174.275601415805;5221.582273418117;5276.788928442896;5279.656822306538;5560.110382338807;5560.777568897199;5574.498295153375;5616.1856530803625;5639.718014099279;5233.017279486644;5274.736263186825;5285.339332583427;5293.841184764463;5296;4632.768361581908;4685.0629874025335;4794.4486384065585;4799.736014519165;4845.200541910615;5701.116326969326;5761.798337058183;5763.769449222068;5800.4489573490455;5869.4717475427415;5543.944560554504;5579.721013949367;5588.105903055654;5589.720513974366;5590.440955904377;5656.264685590847;5797.1304304353;5799.797007104731;5802.738876750641;5807.709614519173;5420.783168673209;5423.864403389947;5478.424765399575;5547.611667183259;5645.604807663589;5623.3533143689;5634.661920284796;5667.659940403424;5669.801556945487;5675.347335056521;5442.510174084351;5447.564194864481;5453.072977593898;5495.807646732345;5511.696856672921;5291.497307755757;5297.629165958346;5366.517013468807;5393.649412788156;5435.918461223164;5457.727113644222;5461.317335333083;5462.617616766788;5463.180522921434;5515.641483303572;5400.567954563547;5401.4868587484125;5485.807996720096;5491.176323551499;5495.862603434946;5416.21464887597;5417.160340147283;5418.539424148834;5430.294061771944;5434.891302174014 00:43:59 INFO - PROCESS | 28715 | |1;ext.html;565.6606036378174;586.4663156527561;593.2110293309898;595.0806004722705;603.0863242188088;34199;41731;42871.57128428719;43066.569334306645;46995;43915.56084439155;44524.554754452445;44572;44572.554274457245;44587.554124458744;7854.607269636524;8842.336824738155;8962.148595883413;8985.820283594325;8992;7963.442559020871;8268.627911743986;8271.172882711711;10423.322484038514;10690.946545267263;10839.620613278497;10917.23579349446;10919.508622111984;10926.672199833978;10937.140686083345;10678.466076696173;10776.353418794897;10777.083947864441;10778;10787.946060269649;10560.894391056068;10628.893711062869;10643.414612196326;10646.0418562329;10649.148068154529;41601.583984160374;41913.58086419158;41941.79029104865;41942.79028604868;41992.370114448306;3356.5133055706788;3497.807620580867;3577.7853328800356;3882.70879684022;3947.486826712509;31239;31285.217869553217;31449.842750786327;31921.36157276865;33159.834200829086;4015.3818637095146;4254.489461264668;4255.787210639455;4376.671749618791;4408.096340250241;331687;331688;332430;333185;335338.32330838434;34203.657963420046;35389;59460;60302.69848650729;60309.39690603125;37223.441648375294;37242;37443.251134977145;37448.25103497915;37458.62541374551;15336.386544538316;15488.22558872052;15508;15524.146171960425;15530.301136448887;12156;12222.633321000385;12230.510779568896;12237.265764054186;12238.694032649255;8033.839323213503;8232.382571307176;8273.710420135387;8623.870641940375;8628.568571571397;3255.8767225307233;3300.323443676872;3337.7663563550805;3344.8494817733263;3386.6274709781906;908.3278374003322;1021.3310281765456;1027.1269420992246;1066.4294602387686;1067.4342598422847;30601;31449.37101257962;31532.36935261282;31612.525812112835;32132.839335803637;1019.6991887393236;1029.5881647340973;1096.7696783675358;1099.8185299425504;1104.5692180049787;15811.604709882115;16444.83555164457;16526.586835329213;16612.58468538296;16742.162891855358;524053;527557;529027.5812765304;530866;531470;57168.71415642895;57221.71389143028;57278.14082788761;57338.42661573331;57950.7102464485;1197.1918954705538;1231.7167051578188;1290.329028904983;1313.2120727563386;1334.7463981843418;28802.423951521272;31962.68037319597;32720.34559308848;33039;33191;49760.751196243786;50598.74700626473;50615;50770.2384464226;50774.23838642497;400167;403794;403838;404387;404482.9551704445;27322.590161147997;27947.44105117927;28022.15933521916;28210;29712;46034.76982615065;46202.83441966133;46285;46432.7678361606;47590.28614570853;38768.6123138765;39018.41472377974;39410.211795764495;41063;41420.792896035324;39580.80209598933;39957.60042399655;40238.597614023485;41016.17967640571;41869.58130418657;39815.80552583427;40652.79673601613;40796.38805417862;40824.3876341861;41268.587314127675;33401.66598333986;36408.81795591005;36556.45165322469;36856.44715329326;37104;27243.59134613022;27506.862465687544;27664.308392290353;27921.20787921273;28960.275993099498 00:43:59 INFO - PROCESS | 28715 | |2;jquery.html;383.9212961342925;386.50141317700167;389.94930659014335;393.7047214589058;419.8803341047802;14288.499902503389;15878.36486540537;17800.91099544502;19356;19390.321338753147;17115.48653540393;17386.130693465308;17463.388781392652;17581.472555823315;18210.635787284245;5515.779368825242;5524.696141712214;5600.383957764642;5649.830505084854;5756.079027355624;5586.91619625706;5655.830325090254;5674.205611214413;5677.858053548653;5680.460356266148;5515.531179849718;5646.18130371096;5648.265725455705;5756.3092428908585;5768.451997060272;5812.564057695668;5840.97079514604;5841.883162336772;5848.561357898175;5857.414258574151;5542.584306177053;5687.289088863892;5716.8856622867725;5723.198752174657;5729.713514324267;12990.675233119153;13306.933465332708;13578.660533486742;13762.793558096637;13832.585022449242;2349.9647505287435;2427.4659574893494;2791.902283420091;2877.13685894233;2894.768418526513;9798.804023919552;10249.9487502562;10500.317479363817;12352.949999250075;13632.182069075887;1850.7408962745226;1925.7496525451602;1957.0997341223053;1965.4398496428448;2043;78909;79670.20329796686;79728;83129;84746.57626711889;9197.63209471627;9516.809663806685;9681.37071090391;9849.162821160282;9935.708372782408;13333.733325333438;13414.12808167466;13430.664233394047;13436.664083397993;13628;7381.37258333037;7789.221077892279;7877.7636670899965;8175.877361839577;8400.117987611213;7374.133072172341;7415.555066696015;7421.589897919378;7800.375969922393;7886.842263154819;4691.437027556715;4756.762161891892;4781.187198176319;4798.880027999258;4923.507649235048;1931.304730297092;1945.9318923837882;1976.7627884653934;2010.4069299556666;2024.2813801100692;851.8211175653058;881.6605606841413;928.2388441477923;957.6313119449062;1007.1238022920106;17056.914715426345;18336.81663183351;18395.172217250256;18704.53238669017;18713.157907894176;937.9437233765996;959.5633986536109;978.2272005115879;1000.2548101664306;1018.0176130034553;9988.200943924468;9991.150752186;10267.794644107076;10407.479626018669;10419.687409377731;390302;390840;397634;400846;401863;92001;92002.53998729963;92224;93267;93313.5334323324;856.8650388205311;884.2704768565959;898.6135961536602;907.3648446087765;911.3119594706087;15330.623753318254;15440.2279886003;16119.919400402923;16317.592060198114;16452;38429.6157038426;39344.60655393409;40123.39814902837;41089.58910410977;42107.36838947357;57922.13116803335;59066.70466647639;59147;59196.40803591909;60057.69971150116;6209.96895015522;8068.9596552016865;8163.102058773649;8221;8463.899693040112;11568.826467603161;12930.224186548838;13063.869361306266;13103.410346534238;13209.141405808592;11264.211505194558;11292.491837867152;11318.830217546578;11478.139139564399;11999.96000679869;11137.554497819996;11177.944110279397;11265.155113366367;11267.605633802777;11620;11435.428228588704;11558.190926635054;11605.2592111184;11611.709707257049;11752.353620550952;7450.96274518624;7586.127595326608;8210.055843577826;8259.587020649064;8986.101389860962;10643.201759867887;10905.78188436211;11031.944840276068;11195.496202670736;11423.543058277575 00:43:59 INFO - PROCESS | 28715 | |3;mootools.html;1326.661701266177;1404.8524954486154;1452.0416525093437;1548.8296287408384;1750.1249375312352;7559.6598153083105;8264.33885289177;8553.40126191167;8576.699815506467;8804;8565.828683426327;8566.571671416435;8574.228319451247;8633.395662303641;8692.652293908237;2233.2406981626286;2239.3729755668355;2241.6886121618872;2250.909963601454;2264.9660255096187;2232.285668586053;2263.4341414646337;2284.166279308049;2292.151903795598;2296.575133600281;2235.619944609412;2244.3491387497606;2257.3905045637666;2259.491614386758;2259.548090381922;2129.4782778219283;2155.838312126581;2157.2341818654468;2157.9568408631817;2166.057764872278;2167.8293721390432;2174.184680744721;2176.3579743975565;2177.7713340099376;2178.0198910490185;8359.289460395874;8521.57392130391;8566.400351975364;8609.139086091403;8626.18051285127;4956.603471722254;5220.504052115043;5225.555827754645;5234.607404444644;5234.81678141267;3080.118495546847;3234.692704193098;3254.1864533866533;3275.623303320101;3301.207710149547;1143.2397455691955;1143.799835028875;1149.0979581028853;1156.7570810129882;1179.0803173524578;11754.882451175465;11805.822912656316;11844.940775296154;11869.347185904771;11880.762384752343;4099.1801639672185;4254.936175957363;4312.482502099768;4351.6301114405;4357.433533640607;9375.671851485302;9394.812103757886;9404.529773511296;9417.058294170529;9421.952890235641;4982.725950072709;4988.950110498921;5025.422076461254;5031.622628302892;5059.949400506021;4085.8774236772942;4088.5911408858874;4131.215069136914;4729.408823897013;4733.455652599995;3394.864205431755;3609.5488063992;3620.330238905811;3670.4861319415304;3673.3387990162028;1059.5443959097663;1101.2126329674322;1104.6630777612745;1107.4739498738036;1110.7112150840678;755.2560727683227;875.4790899414838;883.969061082859;887.662688178488;891.6656253904786;5015.899682006339;5019.47295533971;5242.501962313574;5272.841814745564;5342.332208473941;416.85826818881725;417.82033725498326;420.6992000719439;422.30952392837315;959.2805395953035;3502.984134600937;3741.5136032315627;3826.4642949987024;3828.349180639298;3837.328467518173;9909.752256193653;10044.648437304659;10179.592816287413;10217.693469195936;10292.176625869912;10129.797404051878;10149.98500149979;10152.492375381202;10171.643992460376;10178.847317290247;7963.362930965624;8012.839743205103;8123.593820309079;8176.509409435453;8186.0586032605825;5002.874928126826;5305.893882122413;5374.919376209438;5474.698891561003;5611.270534830609;9840.212782977487;9849.409035457895;9873.605055797974;9962.55168517404;10044.192045431892;8865.556722163996;9601.759956001157;10322.432266225429;10341.74145646365;10346.948265258927;7117.928820711933;7477.551346919202;7615.238476152562;7722.073351197892;7842.72550460754;8315.126911674188;8331.208535189147;8385.28725058377;8446.831063378575;8463.28062114727;7423.220561840929;7425.554466732014;7458.627068646438;7556.093268807558;7559.697612095454;7321.450891183076;7450.701971921062;7478.06524184477;7559.773206803805;7646.579438130956;6646.767363142267;6733.66331683404;6774.729010839708;6813.1142951415995;6827.556208846409;4665.183592871302;4682.648801339845;4807.61539076866;4826.107170173529;4982.153033984304;4826.758662066813;4899.289603007473;4911.238757992517;4947.82682606107;4984.950150498448 00:43:59 INFO - PROCESS | 28715 | |4;prototype.html;335.5872277099168;340.1394471985875;349.7038877391249;350.9578850537936;351.23430920593097;5310.4158542560335;5320.308359913215;5323.920141197876;5325.360956685194;5340.385855626604;4929.718273248955;5081.364829396325;5100;5103.872403189922;5278.709670968105;3994.460747799039;4018.8593399231104;4085.59144085592;4126.195391898581;4140.627343539081;4107.938380924288;4120.546739858613;4125;4134.813933373005;4144.254034273829;4004.1190937993742;4086.080631857823;4104.343305071189;4107.67138628909;4113.115680128772;4086.8160932758096;4096.651784598313;4103.507579090528;4112.013116851964;4115.526714427834;3625.673689367943;3626.8911932642063;3636.9636303637153;3646.5441819772527;3654.793918007051;4975.253711943201;5091.23631455281;5104.974475127638;5140.478772041164;5159.793608255703;4666.743329116897;4679.415073115861;4690.718556886598;4691.413573303337;4698.177818881716;5446.019716451037;5457.727113644341;5458.2904222451225;5472;5472.370677372113;3734.8879533614036;3973.046468847485;3984.163325701606;3985.4021896715435;3986.7009974252046;5659.490645841894;5678.914816277718;5687.544996400278;5695.231143795576;5712.485876271114;4069.8575549855614;4076.144009757925;4078.3270760324212;4081.2245673321972;4083.2646125396586;4131.814068366931;4140.751554906716;4146.937795933063;4160.126373461547;4167.729097608646;4478.343013085179;4689.366935463669;4714.717116972993;4718.764061796896;4731.243001119873;5477.561795056386;5509.776780583324;5522.66863988154;5559.387088068682;5579.721013949286;1359.7212571423033;1424.3519198764745;1432.7206194791916;1436.892233082523;1440.164704471425;875.6978842299396;916.1800188830958;920.5765347939889;933.663881002852;939.8627660530698;4744.4069491313585;4761.90476190482;4788.664793464424;4818.927716084191;4824.589909857631;4992.326035985096;4999.250112483084;5008.29883816266;5012.724300163453;5023.8492845214705;4796.424429068465;5056.418511871182;5374.48942350476;5381.273528073738;5419.701916394636;2967.807092538978;2985.2536865783554;2997.6103106596;3007;3025.455418024733;5720.914186287209;5864.32560255576;5879;5893.255928977129;5910.556708246812;5761.567882408836;5764.250647415809;5771.278590176228;5779.624324418899;5784.1902133701315;5705.400932902068;5738.368779434259;5812.651240925558;5842.328132264759;5855.097093444562;5395.811146610007;5599.440055994368;5615.691136987341;5656.462636049569;5669.291338582677;5561.860953476195;5584.776608935597;5588.944110558842;5599.160125981135;5607.663540187602;5634.802781902614;5853.1220316952795;5872.383399742966;5874.94125058744;5875.177475153568;4065.89835254121;4079.5925405734974;4098.344264917718;4118.052847845072;4125.50493940717;5650.434956504481;5656.745446454837;5676.120201368794;5679.488846003879;5691.402402747652;5316.388615309134;5499.780008799603;5522.30971128609;5524.558035357081;5529.944700553104;5531.3173111041915;5533.81805461869;5538.667679939216;5545.833624991256;5547.861303467284;5271.499207575274;5410.458954104715;5526.143447765603;5528;5575.330960284792;5341;5551.278333816578;5552.916706249329;5586.553075754011;5592.412796656456;5481.5340696041285;5487.780488780404;5494.395616482264;5499.532539734168;5507.311586051744 00:43:59 INFO - PROCESS | 28715 | |5;yui.html;687.7695971849431;708.4226355520253;736.6611358774963;743.2790193512293;756.1644382956829;14555.56333310001;14778.11331320119;15391.230438478087;15407.845921540782;15426.768598471019;15884;16711.498655040337;16731.49805505834;16740.748888766648;16787.496375108767;762.1349768013317;784.8155683414393;787.6534324897027;787.8857565652977;788.0503992688825;648.0700195219874;665.8401983523944;759.2635143910426;772.5789444752595;777.3625626985873;812.3095368936416;813.3046245460135;815.9347252219808;816.9379806251878;823.3207603726919;813.7477382011566;818.5416166946469;818.5702506184241;819.086718309087;819.4837252530926;489.37360178970977;495.4253066442945;497.3012916851829;499.76760806224917;577.5581680014792;13776.311184440738;13963.232022238773;14531.273436328142;14555.272236388244;14565.70868582633;13796.793048104286;14012.579622611338;14325.283735813271;14331.713365732627;14395;13227.338633068308;13347.933260333637;13401;13485.325733713275;13666.453341866314;4459.799309031069;4499.212637788374;4540.27355623102;4630.398048253705;4764.7617619119255;81348;82554.58722706408;83209.16790832074;83543.58228208881;83914.99999999939;10855;11438.885611143949;11611.303321800719;11694.941525292319;11878.703032424086;22113.447163821034;22125.778742212693;22139.33581992543;22154.88922555377;22158.88920555419;7555.848883022419;7996.938780581061;8027;8134.349252059821;8187.71343002992;4460.487043989918;4465.665075119379;4505.6846020778885;4523.479799822997;4527.47933987589;3128.405602935435;3256.2510622556943;3264.396086723964;3269.4115059289556;3277.8197199154274;599.1252770954368;604.241676695744;616.4328817487922;616.9660668663266;620.3424370167546;538.4830562659812;547.2229434203441;569.9715014249354;590.2562770908686;602.7829981206762;8243.793905152419;8737;8742.176759329626;8973.910260897437;8979.685711000084;528.8576674383313;545.585355130096;568.2300482845767;581.7702007706932;590.9864582241477;4387.561243875587;4764;4843;4872.610191184696;5080.669756465818;66265.66867165633;79830.60084699656;83908.16091839125;127513;127623;61354;63604.36395636077;75543.24456755361;86123.06723256217;105674.47162764137;54352.45647543553;55818.72090639521;56532.71733641306;71990;91445.54277228838;9061.13919177677;9327.58025888823;9368.484733339732;9381.718548443558;9447.385919915183;36805;45459.54540454686;49831;51066.48933510618;51373.48626513687;43854;45408.09183816371;51670.74164629153;52372;59120.86153969181;12359.38203089824;12564.62306130781;12685.4291556882;12749.808752868528;12804.295763733084;14134.102508985428;14194.432222710975;14257.063088797993;14979.925100374428;15045.322960466587;13007.544735934196;13495.932520337336;13523.459061637817;13662.590122296348;14093.652279562823;10863.891361086604;12523;12960.157589756636;13119.606411807661;13500.257485838372;12398;12542.372881356077;12555.372231388577;12625.242485450903;13362.131461454974;10169.694909152737;10402.167826573705;10673.46632668348;10807.35155890649;11199.384033878216;9986.550605222928;10195.23535734808;10422.767066570103;10455.320404173704;10693.198010149114 00:43:59 INFO - PROCESS | 28715 | __end_tp_report 00:43:59 INFO - PROCESS | 28715 | __start_cc_report 00:43:59 INFO - PROCESS | 28715 | _x_x_mozilla_cycle_collect,1276 00:43:59 INFO - PROCESS | 28715 | __end_cc_report 00:43:59 INFO - PROCESS | 28715 | __startTimestamp1475567039658__endTimestamp 00:43:59 INFO - PROCESS | 28715 | 00:43:59 INFO - PROCESS | 28715 | ------- Summary: start ------- 00:43:59 INFO - PROCESS | 28715 | Number of tests: 6 00:43:59 INFO - PROCESS | 28715 | 00:43:59 INFO - PROCESS | 28715 | [#0] dojo.html Cycles:165 Average:5185.59 Median:5400.57 stddev:571.15 (10.6%) stddev-sans-first:545.47 00:43:59 INFO - PROCESS | 28715 | Values: 2956.2 3012.9 3013.6 3039.0 3062.6 5138.1 5144.9 5205.7 5213.9 5230.8 5235.2 5257.9 5323.5 5330.0 5375.9 4738.7 4793.9 4829.7 4843.0 4850.1 4786.2 4798.1 4806.0 4826.6 4870.5 4819.2 4840.9 4844.2 4895.6 4903.1 4670.0 4701.0 4744.7 4817.4 4862.6 4716.2 4727.5 4731.6 4786.4 4808.7 5143.4 5187.1 5194.9 5198.1 5198.2 5412.8 5467.6 5554.1 5562.3 5567.2 5482.8 5531.0 5534.6 5579.6 5646.4 5199.2 5201.9 5204.5 5204.6 5205.8 5527.3 5655.5 5666.1 5668.5 5721.5 5369.9 5427.8 5470.9 5477.1 5560.9 5515.5 5543.9 5544.8 5556.9 5560.0 5506.5 5541.5 5556.5 5561.6 5616.7 5329.4 5381.0 5421.8 5508.0 5510.0 4320.2 4324.5 4335.1 4375.7 4379.1 3831.6 3849.6 3852.0 3894.3 3895.7 5165.5 5174.3 5221.6 5276.8 5279.7 5560.1 5560.8 5574.5 5616.2 5639.7 5233.0 5274.7 5285.3 5293.8 5296.0 4632.8 4685.1 4794.4 4799.7 4845.2 5701.1 5761.8 5763.8 5800.4 5869.5 5543.9 5579.7 5588.1 5589.7 5590.4 5656.3 5797.1 5799.8 5802.7 5807.7 5420.8 5423.9 5478.4 5547.6 5645.6 5623.4 5634.7 5667.7 5669.8 5675.3 5442.5 5447.6 5453.1 5495.8 5511.7 5291.5 5297.6 5366.5 5393.6 5435.9 5457.7 5461.3 5462.6 5463.2 5515.6 5400.6 5401.5 5485.8 5491.2 5495.9 5416.2 5417.2 5418.5 5430.3 5434.9 00:43:59 INFO - PROCESS | 28715 | 00:43:59 INFO - PROCESS | 28715 | [#1] ext.html Cycles:180 Average:57247.85 Median:36980.22 stddev:113912.22 (308.0%) stddev-sans-first:114152.28 00:43:59 INFO - PROCESS | 28715 | Values: 565.7 586.5 593.2 595.1 603.1 34199.0 41731.0 42871.6 43066.6 46995.0 43915.6 44524.6 44572.0 44572.6 44587.6 7854.6 8842.3 8962.1 8985.8 8992.0 7963.4 8268.6 8271.2 10423.3 10690.9 10839.6 10917.2 10919.5 10926.7 10937.1 10678.5 10776.4 10777.1 10778.0 10787.9 10560.9 10628.9 10643.4 10646.0 10649.1 41601.6 41913.6 41941.8 41942.8 41992.4 3356.5 3497.8 3577.8 3882.7 3947.5 31239.0 31285.2 31449.8 31921.4 33159.8 4015.4 4254.5 4255.8 4376.7 4408.1 331687.0 331688.0 332430.0 333185.0 335338.3 34203.7 35389.0 59460.0 60302.7 60309.4 37223.4 37242.0 37443.3 37448.3 37458.6 15336.4 15488.2 15508.0 15524.1 15530.3 12156.0 12222.6 12230.5 12237.3 12238.7 8033.8 8232.4 8273.7 8623.9 8628.6 3255.9 3300.3 3337.8 3344.8 3386.6 908.3 1021.3 1027.1 1066.4 1067.4 30601.0 31449.4 31532.4 31612.5 32132.8 1019.7 1029.6 1096.8 1099.8 1104.6 15811.6 16444.8 16526.6 16612.6 16742.2 524053.0 527557.0 529027.6 530866.0 531470.0 57168.7 57221.7 57278.1 57338.4 57950.7 1197.2 1231.7 1290.3 1313.2 1334.7 28802.4 31962.7 32720.3 33039.0 33191.0 49760.8 50598.7 50615.0 50770.2 50774.2 400167.0 403794.0 403838.0 404387.0 404483.0 27322.6 27947.4 28022.2 28210.0 29712.0 46034.8 46202.8 46285.0 46432.8 47590.3 38768.6 39018.4 39410.2 41063.0 41420.8 39580.8 39957.6 40238.6 41016.2 41869.6 39815.8 40652.8 40796.4 40824.4 41268.6 33401.7 36408.8 36556.5 36856.4 37104.0 27243.6 27506.9 27664.3 27921.2 28960.3 00:43:59 INFO - PROCESS | 28715 | 00:43:59 INFO - PROCESS | 28715 | [#2] jquery.html Cycles:180 Average:25810.78 Median:220993.20 stddev:66095.19 (29.9%) stddev-sans-first:66253.03 00:43:59 INFO - PROCESS | 28715 | Values: 383.9 386.5 389.9 393.7 419.9 14288.5 15878.4 17800.9 19356.0 19390.3 17115.5 17386.1 17463.4 17581.5 18210.6 5515.8 5524.7 5600.4 5649.8 5756.1 5586.9 5655.8 5674.2 5677.9 5680.5 5515.5 5646.2 5648.3 5756.3 5768.5 5812.6 5841.0 5841.9 5848.6 5857.4 5542.6 5687.3 5716.9 5723.2 5729.7 12990.7 13306.9 13578.7 13762.8 13832.6 2350.0 2427.5 2791.9 2877.1 2894.8 9798.8 10249.9 10500.3 12352.9 13632.2 1850.7 1925.7 1957.1 1965.4 2043.0 78909.0 79670.2 79728.0 83129.0 84746.6 9197.6 9516.8 9681.4 9849.2 9935.7 13333.7 13414.1 13430.7 13436.7 13628.0 7381.4 7789.2 7877.8 8175.9 8400.1 7374.1 7415.6 7421.6 7800.4 7886.8 4691.4 4756.8 4781.2 4798.9 4923.5 1931.3 1945.9 1976.8 2010.4 2024.3 851.8 881.7 928.2 957.6 1007.1 17056.9 18336.8 18395.2 18704.5 18713.2 937.9 959.6 978.2 1000.3 1018.0 9988.2 9991.2 10267.8 10407.5 10419.7 390302.0 390840.0 397634.0 400846.0 401863.0 92001.0 92002.5 92224.0 93267.0 93313.5 856.9 884.3 898.6 907.4 911.3 15330.6 15440.2 16119.9 16317.6 16452.0 38429.6 39344.6 40123.4 41089.6 42107.4 57922.1 59066.7 59147.0 59196.4 60057.7 6210.0 8069.0 8163.1 8221.0 8463.9 11568.8 12930.2 13063.9 13103.4 13209.1 11264.2 11292.5 11318.8 11478.1 12000.0 11137.6 11177.9 11265.2 11267.6 11620.0 11435.4 11558.2 11605.3 11611.7 11752.4 7451.0 7586.1 8210.1 8259.6 8986.1 10643.2 10905.8 11031.9 11195.5 11423.5 00:43:59 INFO - PROCESS | 28715 | 00:43:59 INFO - PROCESS | 28715 | [#3] mootools.html Cycles:180 Average:5512.73 Median:4826.43 stddev:3190.10 (66.1%) stddev-sans-first:3183.54 00:43:59 INFO - PROCESS | 28715 | Values: 1326.7 1404.9 1452.0 1548.8 1750.1 7559.7 8264.3 8553.4 8576.7 8804.0 8565.8 8566.6 8574.2 8633.4 8692.7 2233.2 2239.4 2241.7 2250.9 2265.0 2232.3 2263.4 2284.2 2292.2 2296.6 2235.6 2244.3 2257.4 2259.5 2259.5 2129.5 2155.8 2157.2 2158.0 2166.1 2167.8 2174.2 2176.4 2177.8 2178.0 8359.3 8521.6 8566.4 8609.1 8626.2 4956.6 5220.5 5225.6 5234.6 5234.8 3080.1 3234.7 3254.2 3275.6 3301.2 1143.2 1143.8 1149.1 1156.8 1179.1 11754.9 11805.8 11844.9 11869.3 11880.8 4099.2 4254.9 4312.5 4351.6 4357.4 9375.7 9394.8 9404.5 9417.1 9422.0 4982.7 4989.0 5025.4 5031.6 5059.9 4085.9 4088.6 4131.2 4729.4 4733.5 3394.9 3609.5 3620.3 3670.5 3673.3 1059.5 1101.2 1104.7 1107.5 1110.7 755.3 875.5 884.0 887.7 891.7 5015.9 5019.5 5242.5 5272.8 5342.3 416.9 417.8 420.7 422.3 959.3 3503.0 3741.5 3826.5 3828.3 3837.3 9909.8 10044.6 10179.6 10217.7 10292.2 10129.8 10150.0 10152.5 10171.6 10178.8 7963.4 8012.8 8123.6 8176.5 8186.1 5002.9 5305.9 5374.9 5474.7 5611.3 9840.2 9849.4 9873.6 9962.6 10044.2 8865.6 9601.8 10322.4 10341.7 10346.9 7117.9 7477.6 7615.2 7722.1 7842.7 8315.1 8331.2 8385.3 8446.8 8463.3 7423.2 7425.6 7458.6 7556.1 7559.7 7321.5 7450.7 7478.1 7559.8 7646.6 6646.8 6733.7 6774.7 6813.1 6827.6 4665.2 4682.6 4807.6 4826.1 4982.2 4826.8 4899.3 4911.2 4947.8 4985.0 00:43:59 INFO - PROCESS | 28715 | 00:43:59 INFO - PROCESS | 28715 | [#4] prototype.html Cycles:180 Average:4613.65 Median:5215.65 stddev:1347.62 (25.8%) stddev-sans-first:1312.59 00:43:59 INFO - PROCESS | 28715 | Values: 335.6 340.1 349.7 351.0 351.2 5310.4 5320.3 5323.9 5325.4 5340.4 4929.7 5081.4 5100.0 5103.9 5278.7 3994.5 4018.9 4085.6 4126.2 4140.6 4107.9 4120.5 4125.0 4134.8 4144.3 4004.1 4086.1 4104.3 4107.7 4113.1 4086.8 4096.7 4103.5 4112.0 4115.5 3625.7 3626.9 3637.0 3646.5 3654.8 4975.3 5091.2 5105.0 5140.5 5159.8 4666.7 4679.4 4690.7 4691.4 4698.2 5446.0 5457.7 5458.3 5472.0 5472.4 3734.9 3973.0 3984.2 3985.4 3986.7 5659.5 5678.9 5687.5 5695.2 5712.5 4069.9 4076.1 4078.3 4081.2 4083.3 4131.8 4140.8 4146.9 4160.1 4167.7 4478.3 4689.4 4714.7 4718.8 4731.2 5477.6 5509.8 5522.7 5559.4 5579.7 1359.7 1424.4 1432.7 1436.9 1440.2 875.7 916.2 920.6 933.7 939.9 4744.4 4761.9 4788.7 4818.9 4824.6 4992.3 4999.3 5008.3 5012.7 5023.8 4796.4 5056.4 5374.5 5381.3 5419.7 2967.8 2985.3 2997.6 3007.0 3025.5 5720.9 5864.3 5879.0 5893.3 5910.6 5761.6 5764.3 5771.3 5779.6 5784.2 5705.4 5738.4 5812.7 5842.3 5855.1 5395.8 5599.4 5615.7 5656.5 5669.3 5561.9 5584.8 5588.9 5599.2 5607.7 5634.8 5853.1 5872.4 5874.9 5875.2 4065.9 4079.6 4098.3 4118.1 4125.5 5650.4 5656.7 5676.1 5679.5 5691.4 5316.4 5499.8 5522.3 5524.6 5529.9 5531.3 5533.8 5538.7 5545.8 5547.9 5271.5 5410.5 5526.1 5528.0 5575.3 5341.0 5551.3 5552.9 5586.6 5592.4 5481.5 5487.8 5494.4 5499.5 5507.3 00:43:59 INFO - PROCESS | 28715 | 00:43:59 INFO - PROCESS | 28715 | [#5] yui.html Cycles:180 Average:18479.97 Median:4697.20 stddev:25651.05 (546.1%) stddev-sans-first:25688.21 00:43:59 INFO - PROCESS | 28715 | Values: 687.8 708.4 736.7 743.3 756.2 14555.6 14778.1 15391.2 15407.8 15426.8 15884.0 16711.5 16731.5 16740.7 16787.5 762.1 784.8 787.7 787.9 788.1 648.1 665.8 759.3 772.6 777.4 812.3 813.3 815.9 816.9 823.3 813.7 818.5 818.6 819.1 819.5 489.4 495.4 497.3 499.8 577.6 13776.3 13963.2 14531.3 14555.3 14565.7 13796.8 14012.6 14325.3 14331.7 14395.0 13227.3 13347.9 13401.0 13485.3 13666.5 4459.8 4499.2 4540.3 4630.4 4764.8 81348.0 82554.6 83209.2 83543.6 83915.0 10855.0 11438.9 11611.3 11694.9 11878.7 22113.4 22125.8 22139.3 22154.9 22158.9 7555.8 7996.9 8027.0 8134.3 8187.7 4460.5 4465.7 4505.7 4523.5 4527.5 3128.4 3256.3 3264.4 3269.4 3277.8 599.1 604.2 616.4 617.0 620.3 538.5 547.2 570.0 590.3 602.8 8243.8 8737.0 8742.2 8973.9 8979.7 528.9 545.6 568.2 581.8 591.0 4387.6 4764.0 4843.0 4872.6 5080.7 66265.7 79830.6 83908.2 127513.0 127623.0 61354.0 63604.4 75543.2 86123.1 105674.5 54352.5 55818.7 56532.7 71990.0 91445.5 9061.1 9327.6 9368.5 9381.7 9447.4 36805.0 45459.5 49831.0 51066.5 51373.5 43854.0 45408.1 51670.7 52372.0 59120.9 12359.4 12564.6 12685.4 12749.8 12804.3 14134.1 14194.4 14257.1 14979.9 15045.3 13007.5 13495.9 13523.5 13662.6 14093.7 10863.9 12523.0 12960.2 13119.6 13500.3 12398.0 12542.4 12555.4 12625.2 13362.1 10169.7 10402.2 10673.5 10807.4 11199.4 9986.6 10195.2 10422.8 10455.3 10693.2 00:43:59 INFO - PROCESS | 28715 | -------- Summary: end -------- 00:43:59 INFO - PROCESS | 28715 | 00:44:00 INFO - TEST-INFO | 28715: exit 0 00:44:00 INFO - TEST-OK | dromaeo_css | took 1117134ms 00:44:00 INFO - TEST-START | kraken 00:44:00 INFO - operating with platform_type : linux_ 00:44:00 INFO - Initialising browser for kraken test... 00:44:00 INFO - TEST-INFO | started process 29017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVXPCmf/profile http://localhost:54512/getInfo.html) 00:44:04 INFO - PROCESS | 29017 | __metrics Screen width/height:1600/1200 00:44:04 INFO - PROCESS | 29017 | colorDepth:24 00:44:04 INFO - PROCESS | 29017 | Browser inner width/height: 1024/697 00:44:04 INFO - PROCESS | 29017 | __metrics 00:44:05 INFO - PROCESS | 29017 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:44:05 INFO - PROCESS | 29017 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:44:05 INFO - PROCESS | 29017 | console.error: PushService: 00:44:05 INFO - PROCESS | 29017 | stateChangeProcessEnqueue: Error transitioning state 00:44:05 INFO - PROCESS | 29017 | UnknownError 00:44:06 INFO - TEST-INFO | 29017: exit 0 00:44:06 INFO - Browser initialized. 00:44:06 INFO - Running cycle 1/1 for kraken test... 00:44:06 INFO - TEST-INFO | started process 29100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVXPCmf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:44:18 INFO - PROCESS | 29100 | RSS: Main: 173146112 00:44:18 INFO - PROCESS | 29100 | 00:44:21 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54512/tests/kraken/driver.html?testName=audio-beat-detection) 00:44:22 INFO - PROCESS | 29100 | RSS: Main: 233082880 00:44:22 INFO - PROCESS | 29100 | 00:44:24 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54512/tests/kraken/driver.html?testName=audio-dft) 00:44:25 INFO - PROCESS | 29100 | RSS: Main: 217669632 00:44:25 INFO - PROCESS | 29100 | 00:44:28 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54512/tests/kraken/driver.html?testName=audio-fft) 00:44:28 INFO - PROCESS | 29100 | RSS: Main: 299732992 00:44:28 INFO - PROCESS | 29100 | 00:44:31 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54512/tests/kraken/driver.html?testName=audio-oscillator) 00:44:31 INFO - PROCESS | 29100 | RSS: Main: 210710528 00:44:31 INFO - PROCESS | 29100 | 00:44:33 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:44:34 INFO - PROCESS | 29100 | RSS: Main: 213536768 00:44:34 INFO - PROCESS | 29100 | 00:44:37 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54512/tests/kraken/driver.html?testName=imaging-darkroom) 00:44:38 INFO - PROCESS | 29100 | RSS: Main: 249409536 00:44:38 INFO - PROCESS | 29100 | 00:44:41 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54512/tests/kraken/driver.html?testName=imaging-desaturate) 00:44:42 INFO - PROCESS | 29100 | RSS: Main: 248516608 00:44:42 INFO - PROCESS | 29100 | 00:44:44 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54512/tests/kraken/driver.html?testName=json-parse-financial) 00:44:45 INFO - PROCESS | 29100 | RSS: Main: 248532992 00:44:45 INFO - PROCESS | 29100 | 00:44:47 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:44:47 INFO - PROCESS | 29100 | RSS: Main: 210591744 00:44:47 INFO - PROCESS | 29100 | 00:44:49 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54512/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:44:50 INFO - PROCESS | 29100 | RSS: Main: 218038272 00:44:50 INFO - PROCESS | 29100 | 00:44:52 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:44:52 INFO - PROCESS | 29100 | RSS: Main: 227426304 00:44:52 INFO - PROCESS | 29100 | 00:44:55 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:44:56 INFO - PROCESS | 29100 | RSS: Main: 236847104 00:44:56 INFO - PROCESS | 29100 | 00:44:58 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:44:59 INFO - PROCESS | 29100 | RSS: Main: 232673280 00:44:59 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | Cycle 1(1): loaded http://localhost:54512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54512/tests/kraken/driver.html?testName=ai-astar) 00:45:01 INFO - PROCESS | 29100 | RSS: Main: 283176960 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | __start_tp_report 00:45:01 INFO - PROCESS | 29100 | _x_x_mozilla_page_load 00:45:01 INFO - PROCESS | 29100 | _x_x_mozilla_page_load_details 00:45:01 INFO - PROCESS | 29100 | |i|pagename|runs| 00:45:01 INFO - PROCESS | 29100 | |0;ai-astar;110;111;114;112;113;112;112;113;116;113 00:45:01 INFO - PROCESS | 29100 | |1;audio-beat-detection;154;122;121;164;124;126;122;122;155;125 00:45:01 INFO - PROCESS | 29100 | |2;audio-dft;161;161;159;161;163;162;161;162;160;162 00:45:01 INFO - PROCESS | 29100 | |3;audio-fft;74;74;76;119;76;76;75;76;103;75 00:45:01 INFO - PROCESS | 29100 | |4;audio-oscillator;83;83;114;82;83;83;107;83;81;117 00:45:01 INFO - PROCESS | 29100 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;118;119;119 00:45:01 INFO - PROCESS | 29100 | |6;imaging-darkroom;147;145;147;147;146;146;146;147;146;147 00:45:01 INFO - PROCESS | 29100 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;96;95 00:45:01 INFO - PROCESS | 29100 | |8;json-parse-financial;53;60;52;52;54;54;55;55;54;53 00:45:01 INFO - PROCESS | 29100 | |9;json-stringify-tinderbox;61;60;60;60;61;60;60;61;60;61 00:45:01 INFO - PROCESS | 29100 | |10;stanford-crypto-aes;81;81;79;80;80;79;86;79;80;80 00:45:01 INFO - PROCESS | 29100 | |11;stanford-crypto-ccm;142;134;140;130;131;148;142;126;171;129 00:45:01 INFO - PROCESS | 29100 | |12;stanford-crypto-pbkdf2;166;167;164;165;171;164;166;164;164;165 00:45:01 INFO - PROCESS | 29100 | |13;stanford-crypto-sha256-iterative;68;67;67;65;69;64;65;65;65;65 00:45:01 INFO - PROCESS | 29100 | __end_tp_report 00:45:01 INFO - PROCESS | 29100 | __start_cc_report 00:45:01 INFO - PROCESS | 29100 | _x_x_mozilla_cycle_collect,1654 00:45:01 INFO - PROCESS | 29100 | __end_cc_report 00:45:01 INFO - PROCESS | 29100 | __startTimestamp1475567101385__endTimestamp 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | ------- Summary: start ------- 00:45:01 INFO - PROCESS | 29100 | Number of tests: 14 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.65 (1.5%) stddev-sans-first:1.45 00:45:01 INFO - PROCESS | 29100 | Values: 110.0 111.0 114.0 112.0 113.0 112.0 112.0 113.0 116.0 113.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:125.50 stddev:16.95 (13.5%) stddev-sans-first:16.27 00:45:01 INFO - PROCESS | 29100 | Values: 154.0 122.0 121.0 164.0 124.0 126.0 122.0 122.0 155.0 125.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.20 00:45:01 INFO - PROCESS | 29100 | Values: 161.0 161.0 159.0 161.0 163.0 162.0 161.0 162.0 160.0 162.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.50 stddev:15.56 (20.6%) stddev-sans-first:16.20 00:45:01 INFO - PROCESS | 29100 | Values: 74.0 74.0 76.0 119.0 76.0 76.0 75.0 76.0 103.0 75.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:83.00 stddev:14.75 (17.8%) stddev-sans-first:15.31 00:45:01 INFO - PROCESS | 29100 | Values: 83.0 83.0 114.0 82.0 83.0 83.0 107.0 83.0 81.0 117.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 00:45:01 INFO - PROCESS | 29100 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 119.0 119.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 00:45:01 INFO - PROCESS | 29100 | Values: 147.0 145.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 00:45:01 INFO - PROCESS | 29100 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:2.30 (4.3%) stddev-sans-first:2.40 00:45:01 INFO - PROCESS | 29100 | Values: 53.0 60.0 52.0 52.0 54.0 54.0 55.0 55.0 54.0 53.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 00:45:01 INFO - PROCESS | 29100 | Values: 61.0 60.0 60.0 60.0 61.0 60.0 60.0 61.0 60.0 61.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:2.07 (2.6%) stddev-sans-first:2.19 00:45:01 INFO - PROCESS | 29100 | Values: 81.0 81.0 79.0 80.0 80.0 79.0 86.0 79.0 80.0 80.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:141.00 stddev:13.17 (9.3%) stddev-sans-first:13.94 00:45:01 INFO - PROCESS | 29100 | Values: 142.0 134.0 140.0 130.0 131.0 148.0 142.0 126.0 171.0 129.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.50 stddev:2.17 (1.3%) stddev-sans-first:2.30 00:45:01 INFO - PROCESS | 29100 | Values: 166.0 167.0 164.0 165.0 171.0 164.0 166.0 164.0 164.0 165.0 00:45:01 INFO - PROCESS | 29100 | 00:45:01 INFO - PROCESS | 29100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.63 (2.5%) stddev-sans-first:1.56 00:45:01 INFO - PROCESS | 29100 | Values: 68.0 67.0 67.0 65.0 69.0 64.0 65.0 65.0 65.0 65.0 00:45:01 INFO - PROCESS | 29100 | -------- Summary: end -------- 00:45:01 INFO - PROCESS | 29100 | 00:45:02 INFO - TEST-INFO | 29100: exit 0 00:45:02 INFO - TEST-OK | kraken | took 62089ms 00:45:02 INFO - SUITE-END | took 1179s 00:45:03 INFO - Completed test suite (00:19:39) 00:45:03 INFO - javascript benchmark 00:45:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2956.2313798412415, 3012.939741205176, 3013.6082309299773, 3038.9696103038964, 3062.6477955035166, 5138.126518491856, 5144.948550514503, 5205.687658740479, 5213.8696532586655, 5230.764615592293, 5235.1885457754015, 5257.947420525794, 5323.467653234675, 5330.040592693314, 5375.946240537593, 4738.691985020962, 4793.90412191756, 4829.686070405422, 4843.0, 4850.054239423313, 4786.186348320776, 4798.0643774464, 4805.951940480585, 4826.613870890338, 4870.4885986971385, 4819.156647586676, 4840.903181936359, 4844.224924012141, 4895.608351331903, 4903.141950158726, 4669.976650116728, 4701.036287561042, 4744.691595046345, 4817.445993710733, 4862.635302352338, 4716.174669432869, 4727.479977202505, 4731.621470282369, 4786.425628924517, 4808.735519546423, 5143.3570803649545, 5187.0922588546855, 5194.857091479446, 5198.090334191501, 5198.220266959948, 5412.756425960802, 5467.617266791326, 5554.0835762099205, 5562.332520097614, 5567.164925261202, 5482.80810171646, 5531.0, 5534.640248383883, 5579.609427340088, 5646.378898321182, 5199.168133098686, 5201.921971170435, 5204.479552044765, 5204.557612602971, 5205.765740541685, 5527.2538207342295, 5655.491005809415, 5666.065099258659, 5668.489835914787, 5721.485066344049, 5369.892602147936, 5427.755750991215, 5470.945290547043, 5477.096279113902, 5560.860978475571, 5515.4760297771645, 5543.944560554423, 5544.750486228129, 5556.91664625031, 5560.0, 5506.476884695948, 5541.5289700375115, 5556.499915007668, 5561.610687251854, 5616.747246373841, 5329.440408757102, 5380.977614253279, 5421.756020979065, 5508.0, 5509.953108909374, 4320.2223599751715, 4324.524302326741, 4335.111302183045, 4375.693701440869, 4379.1022840317655, 3831.578526362098, 3849.576546579874, 3852.036990752312, 3894.299026175259, 3895.668868146183, 5165.483451654804, 5174.275601415805, 5221.582273418117, 5276.788928442896, 5279.656822306538, 5560.110382338807, 5560.777568897199, 5574.498295153375, 5616.1856530803625, 5639.718014099279, 5233.017279486644, 5274.736263186825, 5285.339332583427, 5293.841184764463, 5296.0, 4632.768361581908, 4685.0629874025335, 4794.4486384065585, 4799.736014519165, 4845.200541910615, 5701.116326969326, 5761.798337058183, 5763.769449222068, 5800.4489573490455, 5869.4717475427415, 5543.944560554504, 5579.721013949367, 5588.105903055654, 5589.720513974366, 5590.440955904377, 5656.264685590847, 5797.1304304353, 5799.797007104731, 5802.738876750641, 5807.709614519173, 5420.783168673209, 5423.864403389947, 5478.424765399575, 5547.611667183259, 5645.604807663589, 5623.3533143689, 5634.661920284796, 5667.659940403424, 5669.801556945487, 5675.347335056521, 5442.510174084351, 5447.564194864481, 5453.072977593898, 5495.807646732345, 5511.696856672921, 5291.497307755757, 5297.629165958346, 5366.517013468807, 5393.649412788156, 5435.918461223164, 5457.727113644222, 5461.317335333083, 5462.617616766788, 5463.180522921434, 5515.641483303572, 5400.567954563547, 5401.4868587484125, 5485.807996720096, 5491.176323551499, 5495.862603434946, 5416.21464887597, 5417.160340147283, 5418.539424148834, 5430.294061771944, 5434.891302174014], "value": 5147.924322229039, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.6606036378174, 586.4663156527561, 593.2110293309898, 595.0806004722705, 603.0863242188088, 34199.0, 41731.0, 42871.57128428719, 43066.569334306645, 46995.0, 43915.56084439155, 44524.554754452445, 44572.0, 44572.554274457245, 44587.554124458744, 7854.607269636524, 8842.336824738155, 8962.148595883413, 8985.820283594325, 8992.0, 7963.442559020871, 8268.627911743986, 8271.172882711711, 10423.322484038514, 10690.946545267263, 10839.620613278497, 10917.23579349446, 10919.508622111984, 10926.672199833978, 10937.140686083345, 10678.466076696173, 10776.353418794897, 10777.083947864441, 10778.0, 10787.946060269649, 10560.894391056068, 10628.893711062869, 10643.414612196326, 10646.0418562329, 10649.148068154529, 41601.583984160374, 41913.58086419158, 41941.79029104865, 41942.79028604868, 41992.370114448306, 3356.5133055706788, 3497.807620580867, 3577.7853328800356, 3882.70879684022, 3947.486826712509, 31239.0, 31285.217869553217, 31449.842750786327, 31921.36157276865, 33159.834200829086, 4015.3818637095146, 4254.489461264668, 4255.787210639455, 4376.671749618791, 4408.096340250241, 331687.0, 331688.0, 332430.0, 333185.0, 335338.32330838434, 34203.657963420046, 35389.0, 59460.0, 60302.69848650729, 60309.39690603125, 37223.441648375294, 37242.0, 37443.251134977145, 37448.25103497915, 37458.62541374551, 15336.386544538316, 15488.22558872052, 15508.0, 15524.146171960425, 15530.301136448887, 12156.0, 12222.633321000385, 12230.510779568896, 12237.265764054186, 12238.694032649255, 8033.839323213503, 8232.382571307176, 8273.710420135387, 8623.870641940375, 8628.568571571397, 3255.8767225307233, 3300.323443676872, 3337.7663563550805, 3344.8494817733263, 3386.6274709781906, 908.3278374003322, 1021.3310281765456, 1027.1269420992246, 1066.4294602387686, 1067.4342598422847, 30601.0, 31449.37101257962, 31532.36935261282, 31612.525812112835, 32132.839335803637, 1019.6991887393236, 1029.5881647340973, 1096.7696783675358, 1099.8185299425504, 1104.5692180049787, 15811.604709882115, 16444.83555164457, 16526.586835329213, 16612.58468538296, 16742.162891855358, 524053.0, 527557.0, 529027.5812765304, 530866.0, 531470.0, 57168.71415642895, 57221.71389143028, 57278.14082788761, 57338.42661573331, 57950.7102464485, 1197.1918954705538, 1231.7167051578188, 1290.329028904983, 1313.2120727563386, 1334.7463981843418, 28802.423951521272, 31962.68037319597, 32720.34559308848, 33039.0, 33191.0, 49760.751196243786, 50598.74700626473, 50615.0, 50770.2384464226, 50774.23838642497, 400167.0, 403794.0, 403838.0, 404387.0, 404482.9551704445, 27322.590161147997, 27947.44105117927, 28022.15933521916, 28210.0, 29712.0, 46034.76982615065, 46202.83441966133, 46285.0, 46432.7678361606, 47590.28614570853, 38768.6123138765, 39018.41472377974, 39410.211795764495, 41063.0, 41420.792896035324, 39580.80209598933, 39957.60042399655, 40238.597614023485, 41016.17967640571, 41869.58130418657, 39815.80552583427, 40652.79673601613, 40796.38805417862, 40824.3876341861, 41268.587314127675, 33401.66598333986, 36408.81795591005, 36556.45165322469, 36856.44715329326, 37104.0, 27243.59134613022, 27506.862465687544, 27664.308392290353, 27921.20787921273, 28960.275993099498], "value": 18906.288801161467, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9212961342925, 386.50141317700167, 389.94930659014335, 393.7047214589058, 419.8803341047802, 14288.499902503389, 15878.36486540537, 17800.91099544502, 19356.0, 19390.321338753147, 17115.48653540393, 17386.130693465308, 17463.388781392652, 17581.472555823315, 18210.635787284245, 5515.779368825242, 5524.696141712214, 5600.383957764642, 5649.830505084854, 5756.079027355624, 5586.91619625706, 5655.830325090254, 5674.205611214413, 5677.858053548653, 5680.460356266148, 5515.531179849718, 5646.18130371096, 5648.265725455705, 5756.3092428908585, 5768.451997060272, 5812.564057695668, 5840.97079514604, 5841.883162336772, 5848.561357898175, 5857.414258574151, 5542.584306177053, 5687.289088863892, 5716.8856622867725, 5723.198752174657, 5729.713514324267, 12990.675233119153, 13306.933465332708, 13578.660533486742, 13762.793558096637, 13832.585022449242, 2349.9647505287435, 2427.4659574893494, 2791.902283420091, 2877.13685894233, 2894.768418526513, 9798.804023919552, 10249.9487502562, 10500.317479363817, 12352.949999250075, 13632.182069075887, 1850.7408962745226, 1925.7496525451602, 1957.0997341223053, 1965.4398496428448, 2043.0, 78909.0, 79670.20329796686, 79728.0, 83129.0, 84746.57626711889, 9197.63209471627, 9516.809663806685, 9681.37071090391, 9849.162821160282, 9935.708372782408, 13333.733325333438, 13414.12808167466, 13430.664233394047, 13436.664083397993, 13628.0, 7381.37258333037, 7789.221077892279, 7877.7636670899965, 8175.877361839577, 8400.117987611213, 7374.133072172341, 7415.555066696015, 7421.589897919378, 7800.375969922393, 7886.842263154819, 4691.437027556715, 4756.762161891892, 4781.187198176319, 4798.880027999258, 4923.507649235048, 1931.304730297092, 1945.9318923837882, 1976.7627884653934, 2010.4069299556666, 2024.2813801100692, 851.8211175653058, 881.6605606841413, 928.2388441477923, 957.6313119449062, 1007.1238022920106, 17056.914715426345, 18336.81663183351, 18395.172217250256, 18704.53238669017, 18713.157907894176, 937.9437233765996, 959.5633986536109, 978.2272005115879, 1000.2548101664306, 1018.0176130034553, 9988.200943924468, 9991.150752186, 10267.794644107076, 10407.479626018669, 10419.687409377731, 390302.0, 390840.0, 397634.0, 400846.0, 401863.0, 92001.0, 92002.53998729963, 92224.0, 93267.0, 93313.5334323324, 856.8650388205311, 884.2704768565959, 898.6135961536602, 907.3648446087765, 911.3119594706087, 15330.623753318254, 15440.2279886003, 16119.919400402923, 16317.592060198114, 16452.0, 38429.6157038426, 39344.60655393409, 40123.39814902837, 41089.58910410977, 42107.36838947357, 57922.13116803335, 59066.70466647639, 59147.0, 59196.40803591909, 60057.69971150116, 6209.96895015522, 8068.9596552016865, 8163.102058773649, 8221.0, 8463.899693040112, 11568.826467603161, 12930.224186548838, 13063.869361306266, 13103.410346534238, 13209.141405808592, 11264.211505194558, 11292.491837867152, 11318.830217546578, 11478.139139564399, 11999.96000679869, 11137.554497819996, 11177.944110279397, 11265.155113366367, 11267.605633802777, 11620.0, 11435.428228588704, 11558.190926635054, 11605.2592111184, 11611.709707257049, 11752.353620550952, 7450.96274518624, 7586.127595326608, 8210.055843577826, 8259.587020649064, 8986.101389860962, 10643.201759867887, 10905.78188436211, 11031.944840276068, 11195.496202670736, 11423.543058277575], "value": 8789.449507830906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.661701266177, 1404.8524954486154, 1452.0416525093437, 1548.8296287408384, 1750.1249375312352, 7559.6598153083105, 8264.33885289177, 8553.40126191167, 8576.699815506467, 8804.0, 8565.828683426327, 8566.571671416435, 8574.228319451247, 8633.395662303641, 8692.652293908237, 2233.2406981626286, 2239.3729755668355, 2241.6886121618872, 2250.909963601454, 2264.9660255096187, 2232.285668586053, 2263.4341414646337, 2284.166279308049, 2292.151903795598, 2296.575133600281, 2235.619944609412, 2244.3491387497606, 2257.3905045637666, 2259.491614386758, 2259.548090381922, 2129.4782778219283, 2155.838312126581, 2157.2341818654468, 2157.9568408631817, 2166.057764872278, 2167.8293721390432, 2174.184680744721, 2176.3579743975565, 2177.7713340099376, 2178.0198910490185, 8359.289460395874, 8521.57392130391, 8566.400351975364, 8609.139086091403, 8626.18051285127, 4956.603471722254, 5220.504052115043, 5225.555827754645, 5234.607404444644, 5234.81678141267, 3080.118495546847, 3234.692704193098, 3254.1864533866533, 3275.623303320101, 3301.207710149547, 1143.2397455691955, 1143.799835028875, 1149.0979581028853, 1156.7570810129882, 1179.0803173524578, 11754.882451175465, 11805.822912656316, 11844.940775296154, 11869.347185904771, 11880.762384752343, 4099.1801639672185, 4254.936175957363, 4312.482502099768, 4351.6301114405, 4357.433533640607, 9375.671851485302, 9394.812103757886, 9404.529773511296, 9417.058294170529, 9421.952890235641, 4982.725950072709, 4988.950110498921, 5025.422076461254, 5031.622628302892, 5059.949400506021, 4085.8774236772942, 4088.5911408858874, 4131.215069136914, 4729.408823897013, 4733.455652599995, 3394.864205431755, 3609.5488063992, 3620.330238905811, 3670.4861319415304, 3673.3387990162028, 1059.5443959097663, 1101.2126329674322, 1104.6630777612745, 1107.4739498738036, 1110.7112150840678, 755.2560727683227, 875.4790899414838, 883.969061082859, 887.662688178488, 891.6656253904786, 5015.899682006339, 5019.47295533971, 5242.501962313574, 5272.841814745564, 5342.332208473941, 416.85826818881725, 417.82033725498326, 420.6992000719439, 422.30952392837315, 959.2805395953035, 3502.984134600937, 3741.5136032315627, 3826.4642949987024, 3828.349180639298, 3837.328467518173, 9909.752256193653, 10044.648437304659, 10179.592816287413, 10217.693469195936, 10292.176625869912, 10129.797404051878, 10149.98500149979, 10152.492375381202, 10171.643992460376, 10178.847317290247, 7963.362930965624, 8012.839743205103, 8123.593820309079, 8176.509409435453, 8186.0586032605825, 5002.874928126826, 5305.893882122413, 5374.919376209438, 5474.698891561003, 5611.270534830609, 9840.212782977487, 9849.409035457895, 9873.605055797974, 9962.55168517404, 10044.192045431892, 8865.556722163996, 9601.759956001157, 10322.432266225429, 10341.74145646365, 10346.948265258927, 7117.928820711933, 7477.551346919202, 7615.238476152562, 7722.073351197892, 7842.72550460754, 8315.126911674188, 8331.208535189147, 8385.28725058377, 8446.831063378575, 8463.28062114727, 7423.220561840929, 7425.554466732014, 7458.627068646438, 7556.093268807558, 7559.697612095454, 7321.450891183076, 7450.701971921062, 7478.06524184477, 7559.773206803805, 7646.579438130956, 6646.767363142267, 6733.66331683404, 6774.729010839708, 6813.1142951415995, 6827.556208846409, 4665.183592871302, 4682.648801339845, 4807.61539076866, 4826.107170173529, 4982.153033984304, 4826.758662066813, 4899.289603007473, 4911.238757992517, 4947.82682606107, 4984.950150498448], "value": 4334.69243477104, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.5872277099168, 340.1394471985875, 349.7038877391249, 350.9578850537936, 351.23430920593097, 5310.4158542560335, 5320.308359913215, 5323.920141197876, 5325.360956685194, 5340.385855626604, 4929.718273248955, 5081.364829396325, 5100.0, 5103.872403189922, 5278.709670968105, 3994.460747799039, 4018.8593399231104, 4085.59144085592, 4126.195391898581, 4140.627343539081, 4107.938380924288, 4120.546739858613, 4125.0, 4134.813933373005, 4144.254034273829, 4004.1190937993742, 4086.080631857823, 4104.343305071189, 4107.67138628909, 4113.115680128772, 4086.8160932758096, 4096.651784598313, 4103.507579090528, 4112.013116851964, 4115.526714427834, 3625.673689367943, 3626.8911932642063, 3636.9636303637153, 3646.5441819772527, 3654.793918007051, 4975.253711943201, 5091.23631455281, 5104.974475127638, 5140.478772041164, 5159.793608255703, 4666.743329116897, 4679.415073115861, 4690.718556886598, 4691.413573303337, 4698.177818881716, 5446.019716451037, 5457.727113644341, 5458.2904222451225, 5472.0, 5472.370677372113, 3734.8879533614036, 3973.046468847485, 3984.163325701606, 3985.4021896715435, 3986.7009974252046, 5659.490645841894, 5678.914816277718, 5687.544996400278, 5695.231143795576, 5712.485876271114, 4069.8575549855614, 4076.144009757925, 4078.3270760324212, 4081.2245673321972, 4083.2646125396586, 4131.814068366931, 4140.751554906716, 4146.937795933063, 4160.126373461547, 4167.729097608646, 4478.343013085179, 4689.366935463669, 4714.717116972993, 4718.764061796896, 4731.243001119873, 5477.561795056386, 5509.776780583324, 5522.66863988154, 5559.387088068682, 5579.721013949286, 1359.7212571423033, 1424.3519198764745, 1432.7206194791916, 1436.892233082523, 1440.164704471425, 875.6978842299396, 916.1800188830958, 920.5765347939889, 933.663881002852, 939.8627660530698, 4744.4069491313585, 4761.90476190482, 4788.664793464424, 4818.927716084191, 4824.589909857631, 4992.326035985096, 4999.250112483084, 5008.29883816266, 5012.724300163453, 5023.8492845214705, 4796.424429068465, 5056.418511871182, 5374.48942350476, 5381.273528073738, 5419.701916394636, 2967.807092538978, 2985.2536865783554, 2997.6103106596, 3007.0, 3025.455418024733, 5720.914186287209, 5864.32560255576, 5879.0, 5893.255928977129, 5910.556708246812, 5761.567882408836, 5764.250647415809, 5771.278590176228, 5779.624324418899, 5784.1902133701315, 5705.400932902068, 5738.368779434259, 5812.651240925558, 5842.328132264759, 5855.097093444562, 5395.811146610007, 5599.440055994368, 5615.691136987341, 5656.462636049569, 5669.291338582677, 5561.860953476195, 5584.776608935597, 5588.944110558842, 5599.160125981135, 5607.663540187602, 5634.802781902614, 5853.1220316952795, 5872.383399742966, 5874.94125058744, 5875.177475153568, 4065.89835254121, 4079.5925405734974, 4098.344264917718, 4118.052847845072, 4125.50493940717, 5650.434956504481, 5656.745446454837, 5676.120201368794, 5679.488846003879, 5691.402402747652, 5316.388615309134, 5499.780008799603, 5522.30971128609, 5524.558035357081, 5529.944700553104, 5531.3173111041915, 5533.81805461869, 5538.667679939216, 5545.833624991256, 5547.861303467284, 5271.499207575274, 5410.458954104715, 5526.143447765603, 5528.0, 5575.330960284792, 5341.0, 5551.278333816578, 5552.916706249329, 5586.553075754011, 5592.412796656456, 5481.5340696041285, 5487.780488780404, 5494.395616482264, 5499.532539734168, 5507.311586051744], "value": 4188.719565992852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.7695971849431, 708.4226355520253, 736.6611358774963, 743.2790193512293, 756.1644382956829, 14555.56333310001, 14778.11331320119, 15391.230438478087, 15407.845921540782, 15426.768598471019, 15884.0, 16711.498655040337, 16731.49805505834, 16740.748888766648, 16787.496375108767, 762.1349768013317, 784.8155683414393, 787.6534324897027, 787.8857565652977, 788.0503992688825, 648.0700195219874, 665.8401983523944, 759.2635143910426, 772.5789444752595, 777.3625626985873, 812.3095368936416, 813.3046245460135, 815.9347252219808, 816.9379806251878, 823.3207603726919, 813.7477382011566, 818.5416166946469, 818.5702506184241, 819.086718309087, 819.4837252530926, 489.37360178970977, 495.4253066442945, 497.3012916851829, 499.76760806224917, 577.5581680014792, 13776.311184440738, 13963.232022238773, 14531.273436328142, 14555.272236388244, 14565.70868582633, 13796.793048104286, 14012.579622611338, 14325.283735813271, 14331.713365732627, 14395.0, 13227.338633068308, 13347.933260333637, 13401.0, 13485.325733713275, 13666.453341866314, 4459.799309031069, 4499.212637788374, 4540.27355623102, 4630.398048253705, 4764.7617619119255, 81348.0, 82554.58722706408, 83209.16790832074, 83543.58228208881, 83914.99999999939, 10855.0, 11438.885611143949, 11611.303321800719, 11694.941525292319, 11878.703032424086, 22113.447163821034, 22125.778742212693, 22139.33581992543, 22154.88922555377, 22158.88920555419, 7555.848883022419, 7996.938780581061, 8027.0, 8134.349252059821, 8187.71343002992, 4460.487043989918, 4465.665075119379, 4505.6846020778885, 4523.479799822997, 4527.47933987589, 3128.405602935435, 3256.2510622556943, 3264.396086723964, 3269.4115059289556, 3277.8197199154274, 599.1252770954368, 604.241676695744, 616.4328817487922, 616.9660668663266, 620.3424370167546, 538.4830562659812, 547.2229434203441, 569.9715014249354, 590.2562770908686, 602.7829981206762, 8243.793905152419, 8737.0, 8742.176759329626, 8973.910260897437, 8979.685711000084, 528.8576674383313, 545.585355130096, 568.2300482845767, 581.7702007706932, 590.9864582241477, 4387.561243875587, 4764.0, 4843.0, 4872.610191184696, 5080.669756465818, 66265.66867165633, 79830.60084699656, 83908.16091839125, 127513.0, 127623.0, 61354.0, 63604.36395636077, 75543.24456755361, 86123.06723256217, 105674.47162764137, 54352.45647543553, 55818.72090639521, 56532.71733641306, 71990.0, 91445.54277228838, 9061.13919177677, 9327.58025888823, 9368.484733339732, 9381.718548443558, 9447.385919915183, 36805.0, 45459.54540454686, 49831.0, 51066.48933510618, 51373.48626513687, 43854.0, 45408.09183816371, 51670.74164629153, 52372.0, 59120.86153969181, 12359.38203089824, 12564.62306130781, 12685.4291556882, 12749.808752868528, 12804.295763733084, 14134.102508985428, 14194.432222710975, 14257.063088797993, 14979.925100374428, 15045.322960466587, 13007.544735934196, 13495.932520337336, 13523.459061637817, 13662.590122296348, 14093.652279562823, 10863.891361086604, 12523.0, 12960.157589756636, 13119.606411807661, 13500.257485838372, 12398.0, 12542.372881356077, 12555.372231388577, 12625.242485450903, 13362.131461454974, 10169.694909152737, 10402.167826573705, 10673.46632668348, 10807.35155890649, 11199.384033878216, 9986.550605222928, 10195.23535734808, 10422.767066570103, 10455.320404173704, 10693.198010149114], "value": 7096.33015330412, "unit": "score"}], "name": "dromaeo_css", "value": 6924.469378629243, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 114.0, 112.0, 113.0, 112.0, 112.0, 113.0, 116.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 121.0, 164.0, 124.0, 126.0, 122.0, 122.0, 155.0, 125.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 161.0, 163.0, 162.0, 161.0, 162.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 119.0, 76.0, 76.0, 75.0, 76.0, 103.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 82.0, 83.0, 83.0, 107.0, 83.0, 81.0, 117.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 60.0, 52.0, 52.0, 54.0, 54.0, 55.0, 55.0, 54.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 79.0, 80.0, 80.0, 79.0, 86.0, 79.0, 80.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 140.0, 130.0, 131.0, 148.0, 142.0, 126.0, 171.0, 129.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 164.0, 165.0, 171.0, 164.0, 166.0, 164.0, 164.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 65.0, 69.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1507.3999999999999, "alertThreshold": 2.0}]} 00:45:03 INFO - Return code: 0 00:45:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:45:03 INFO - # TBPL SUCCESS # 00:45:03 INFO - Running post-action listener: _resource_record_post_action 00:45:03 INFO - [mozharness: 2016-10-04 07:45:03.183818Z] Finished run-tests step (success) 00:45:03 INFO - Running post-run listener: _resource_record_post_run 00:45:03 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403558400; Read time: 8; Write time: 316044 00:45:03 INFO - TinderboxPrint: CPU usage
13.1% 00:45:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 00:45:03 INFO - TinderboxPrint: I/O write bytes / time
403,558,400 / 316,044 00:45:03 INFO - TinderboxPrint: CPU idle
8,302.7 (86.9%) 00:45:03 INFO - TinderboxPrint: CPU user
1,198.3 (12.5%) 00:45:03 INFO - TinderboxPrint: Swap in / out
0 / 0 00:45:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103870464; Read time: 0; Write time: 119016 00:45:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288567296; Read time: 0; Write time: 193448 00:45:03 INFO - Running post-run listener: _upload_blobber_files 00:45:03 INFO - Blob upload gear active. 00:45:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:45:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:45:03 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:45:03 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:45:04 INFO - (blobuploader) - INFO - Open directory for files ... 00:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:45:07 INFO - (blobuploader) - INFO - Done attempting. 00:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:45:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:45:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:45:08 INFO - (blobuploader) - INFO - Done attempting. 00:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:45:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:45:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:45:08 INFO - (blobuploader) - INFO - Done attempting. 00:45:08 INFO - (blobuploader) - INFO - Iteration through files over. 00:45:08 INFO - Return code: 0 00:45:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:45:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:45:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60e745d5fa0838a52c5f37b81cbeb714fa1da118ac739979e290f567b63c07b742581c1866eae580f8120f0e2dc9a1d07215e35fc0771bd4030f8639b42baec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe019907db4a402d9d9730d7c1b00b00d05831463083cfd8f844da441e9f568667b906a4061fbcfaddbdcd2eb3089295bca086304b0ac26232772b3d291932b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcfed1075b7cba8fcbbf41eaf5d2e655d03594cf7baf729db4bf690af8dab49646b530437a989807c89bae02faa357d054c102b9fb257f4df2174ef2392ba297"} 00:45:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:45:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:45:08 INFO - Contents: 00:45:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60e745d5fa0838a52c5f37b81cbeb714fa1da118ac739979e290f567b63c07b742581c1866eae580f8120f0e2dc9a1d07215e35fc0771bd4030f8639b42baec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe019907db4a402d9d9730d7c1b00b00d05831463083cfd8f844da441e9f568667b906a4061fbcfaddbdcd2eb3089295bca086304b0ac26232772b3d291932b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcfed1075b7cba8fcbbf41eaf5d2e655d03594cf7baf729db4bf690af8dab49646b530437a989807c89bae02faa357d054c102b9fb257f4df2174ef2392ba297"} 00:45:08 INFO - Running post-run listener: copy_logs_to_upload_dir 00:45:08 INFO - Copying logs to upload dir... 00:45:08 INFO - mkdir: /builds/slave/test/build/upload/logs 00:45:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.099537 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-04 00:45:08.037186) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 00:45:08.040665) ========= 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=523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60e745d5fa0838a52c5f37b81cbeb714fa1da118ac739979e290f567b63c07b742581c1866eae580f8120f0e2dc9a1d07215e35fc0771bd4030f8639b42baec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe019907db4a402d9d9730d7c1b00b00d05831463083cfd8f844da441e9f568667b906a4061fbcfaddbdcd2eb3089295bca086304b0ac26232772b3d291932b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcfed1075b7cba8fcbbf41eaf5d2e655d03594cf7baf729db4bf690af8dab49646b530437a989807c89bae02faa357d054c102b9fb257f4df2174ef2392ba297"} build_url:https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/Pq7dK1meQHu8hg0MoUYtdw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60e745d5fa0838a52c5f37b81cbeb714fa1da118ac739979e290f567b63c07b742581c1866eae580f8120f0e2dc9a1d07215e35fc0771bd4030f8639b42baec9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe019907db4a402d9d9730d7c1b00b00d05831463083cfd8f844da441e9f568667b906a4061fbcfaddbdcd2eb3089295bca086304b0ac26232772b3d291932b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcfed1075b7cba8fcbbf41eaf5d2e655d03594cf7baf729db4bf690af8dab49646b530437a989807c89bae02faa357d054c102b9fb257f4df2174ef2392ba297"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 00:45:08.066166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:45:08.066525) ========= 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=523ca41ca1e0623de333ad52000001bf-1475565867.962645-2049511483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:45:08.149217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 00:45:08.149559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 00:45:08.149884) ========= ========= Total master_lag: 0.37 =========