builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1475550658.9 results: success (0) buildid: 20161003183005 builduid: 4d8e2242b58c4b44b7efd34d2c71048d revision: b26e668306fba754bba594572ac721bf5b0990ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:58.904891) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:58.906927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:58.907309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:58.922495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:58.922801) ========= 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=7de08804244eb36560b44971000001c3-1475549891.499186-2097100403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 20:10:59-- 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% 22.8M=0.001s 2016-10-03 20:10:59 (22.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128646 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:59.065478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:59.065823) ========= 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=7de08804244eb36560b44971000001c3-1475549891.499186-2097100403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019170 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:59.121049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:59.121447) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b26e668306fba754bba594572ac721bf5b0990ef --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 b26e668306fba754bba594572ac721bf5b0990ef --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=7de08804244eb36560b44971000001c3-1475549891.499186-2097100403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 20:10:59,401 truncating revision to first 12 chars 2016-10-03 20:10:59,401 Setting DEBUG logging. 2016-10-03 20:10:59,401 attempt 1/10 2016-10-03 20:10:59,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b26e668306fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 20:10:59,697 unpacking tar archive at: fx-team-b26e668306fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635913 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:59.780877) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:59.781267) ========= script_repo_revision: b26e668306fba754bba594572ac721bf5b0990ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:59.781762) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:59.782131) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 20:10:59.793806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-03 20:10:59.794161) ========= /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=7de08804244eb36560b44971000001c3-1475549891.499186-2097100403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:11:00 INFO - MultiFileLogger online at 20161003 20:11:00 in /builds/slave/test 20:11:00 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 20:11:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:11:00 INFO - {'append_to_log': False, 20:11:00 INFO - 'base_work_dir': '/builds/slave/test', 20:11:00 INFO - 'blob_upload_branch': 'Fx-Team', 20:11:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:11:00 INFO - 'branch': 'Fx-Team', 20:11:00 INFO - 'buildbot_json_path': 'buildprops.json', 20:11:00 INFO - 'config_files': ('talos/linux_config.py',), 20:11:00 INFO - 'default_actions': ('clobber', 20:11:00 INFO - 'read-buildbot-config', 20:11:00 INFO - 'download-and-extract', 20:11:00 INFO - 'populate-webroot', 20:11:00 INFO - 'create-virtualenv', 20:11:00 INFO - 'install', 20:11:00 INFO - 'run-tests'), 20:11:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:11:00 INFO - 'download_minidump_stackwalk': True, 20:11:00 INFO - 'download_symbols': 'ondemand', 20:11:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:11:00 INFO - 'tooltool.py': '/tools/tooltool.py', 20:11:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:11:00 INFO - '/tools/misc-python/virtualenv.py')}, 20:11:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:11:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:11:00 INFO - 'installer_path': 'installer.exe', 20:11:00 INFO - 'log_level': 'info', 20:11:00 INFO - 'log_name': 'talos', 20:11:00 INFO - 'log_to_console': True, 20:11:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:11:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:11:00 INFO - 'opt_config_files': (), 20:11:00 INFO - 'pip_index': False, 20:11:00 INFO - 'sps_profile': False, 20:11:00 INFO - 'sps_profile_interval': 0, 20:11:00 INFO - 'suite': 'dromaeojs', 20:11:00 INFO - 'system_bits': '32', 20:11:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:11:00 INFO - 'title': 'talos-linux64-ix-003', 20:11:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:11:00 INFO - 'use_talos_json': True, 20:11:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:11:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:11:00 INFO - 'work_dir': 'build'} 20:11:00 INFO - [mozharness: 2016-10-04 03:11:00.174077Z] Running clobber step. 20:11:00 INFO - Running pre-action listener: _resource_record_pre_action 20:11:00 INFO - Running main action method: clobber 20:11:00 INFO - rmtree: /builds/slave/test/build 20:11:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:11:00 INFO - Running post-action listener: _resource_record_post_action 20:11:00 INFO - [mozharness: 2016-10-04 03:11:00.631154Z] Finished clobber step (success) 20:11:00 INFO - [mozharness: 2016-10-04 03:11:00.631256Z] Running read-buildbot-config step. 20:11:00 INFO - Running pre-action listener: _resource_record_pre_action 20:11:00 INFO - Running main action method: read_buildbot_config 20:11:00 INFO - Using buildbot properties: 20:11:00 INFO - { 20:11:00 INFO - "project": "", 20:11:00 INFO - "product": "firefox", 20:11:00 INFO - "script_repo_revision": "production", 20:11:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:11:00 INFO - "repository": "", 20:11:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:11:00 INFO - "buildid": "20161003183005", 20:11:00 INFO - "pgo_build": "True", 20:11:00 INFO - "basedir": "/builds/slave/test", 20:11:00 INFO - "buildnumber": 496, 20:11:00 INFO - "slavename": "talos-linux64-ix-003", 20:11:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:11:00 INFO - "platform": "ubuntu64_hw", 20:11:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:11:00 INFO - "branch": "fx-team", 20:11:00 INFO - "repo_path": "integration/fx-team", 20:11:00 INFO - "revision": "b26e668306fba754bba594572ac721bf5b0990ef", 20:11:00 INFO - "stage_platform": "linux64-pgo", 20:11:00 INFO - "builduid": "4d8e2242b58c4b44b7efd34d2c71048d", 20:11:00 INFO - "slavebuilddir": "test" 20:11:00 INFO - } 20:11:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:11:00 INFO - Running post-action listener: _resource_record_post_action 20:11:00 INFO - [mozharness: 2016-10-04 03:11:00.633709Z] Finished read-buildbot-config step (success) 20:11:00 INFO - [mozharness: 2016-10-04 03:11:00.633796Z] Running download-and-extract step. 20:11:00 INFO - Running pre-action listener: _resource_record_pre_action 20:11:00 INFO - Running main action method: download_and_extract 20:11:00 INFO - mkdir: /builds/slave/test/build/tests 20:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:00 INFO - trying https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:11:00 INFO - Downloading https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/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 20:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/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 20:11:01 INFO - Downloaded 1361 bytes. 20:11:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:11:01 INFO - Using the following test package requirements: 20:11:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:11:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:11:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:01 INFO - u'jsshell-linux-x86_64.zip'], 20:11:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:11:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:11:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:11:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:11:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:11:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:11:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:11:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:11:01 INFO - Fetch https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:11:01 INFO - Http code: 200 20:11:01 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 20:11:01 INFO - x-amz-cf-id: Dt59tRL3JAApbb3vmMHDRl_JlmNu-k_cYp0mn0EAArn8Y2kmcKJh0w== 20:11:01 INFO - x-amz-version-id: Ta6bk0xTPumjXwe_K9VnpMcK_zVWXoYM 20:11:02 INFO - Expected file size: 21991797 20:11:02 INFO - Obtained file size: 21991797 20:11:06 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 20:11:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:11:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:11:06 INFO - Fetch https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:11:06 INFO - Http code: 200 20:11:06 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 20:11:06 INFO - x-amz-cf-id: 0116zJ3UST_QtmlLhHtmC7bKHvB_4jHElPDOURfBBb54JHPseuOb8Q== 20:11:06 INFO - x-amz-version-id: Ta6bk0xTPumjXwe_K9VnpMcK_zVWXoYM 20:11:07 INFO - Expected file size: 21991797 20:11:07 INFO - Obtained file size: 21991797 20:11:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:11:12 INFO - Fetch https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:11:12 INFO - Http code: 200 20:11:12 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 20:11:12 INFO - x-amz-cf-id: eRhJSv-d37MRqJC-wit_mQ28jD9UVnI4TBga1k9JLboCv4PmX78zpQ== 20:11:12 INFO - x-amz-version-id: FcTpHeqJhHBt2nAq2vq_X9eRueKoLWfU 20:11:13 INFO - Expected file size: 14409006 20:11:13 INFO - Obtained file size: 14409006 20:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:13 INFO - trying https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:13 INFO - Downloading https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/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 20:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/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 20:11:14 INFO - Downloaded 59669916 bytes. 20:11:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:14 INFO - mkdir: /builds/slave/test/properties 20:11:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:11:14 INFO - Writing to file /builds/slave/test/properties/build_url 20:11:14 INFO - Contents: 20:11:14 INFO - build_url:https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:15 INFO - Running post-action listener: _resource_record_post_action 20:11:15 INFO - Running post-action listener: set_extra_try_arguments 20:11:15 INFO - [mozharness: 2016-10-04 03:11:15.455414Z] Finished download-and-extract step (success) 20:11:15 INFO - [mozharness: 2016-10-04 03:11:15.455675Z] Running populate-webroot step. 20:11:15 INFO - Running pre-action listener: _resource_record_pre_action 20:11:15 INFO - Running main action method: populate_webroot 20:11:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:11:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:11:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:11:15 INFO - '--tppagecycles', 20:11:15 INFO - '7'], 20:11:15 INFO - 'tests': ['tsvgm']}}, 20:11:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:11:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:11:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:11:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:11:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:15 INFO - 'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:15 INFO - 'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['damp', 'tps']}, 20:11:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:15 INFO - 'tests': ['damp', 'tps']}, 20:11:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['dromaeo_dom']}, 20:11:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:11:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['basic_compositor_video']}, 20:11:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:11:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['a11yr', 20:11:15 INFO - 'ts_paint', 20:11:15 INFO - 'tpaint', 20:11:15 INFO - 'sessionrestore', 20:11:15 INFO - 'sessionrestore_no_auto_restore', 20:11:15 INFO - 'tabpaint']}, 20:11:15 INFO - 'other-e10s': {'tests': ['a11yr', 20:11:15 INFO - 'ts_paint', 20:11:15 INFO - 'tpaint', 20:11:15 INFO - 'sessionrestore', 20:11:15 INFO - 'sessionrestore_no_auto_restore', 20:11:15 INFO - 'tabpaint']}, 20:11:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:11:15 INFO - 'ts_paint', 20:11:15 INFO - 'tpaint', 20:11:15 INFO - 'sessionrestore', 20:11:15 INFO - 'sessionrestore_no_auto_restore', 20:11:15 INFO - 'tabpaint']}, 20:11:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:11:15 INFO - 'ts_paint', 20:11:15 INFO - 'tpaint', 20:11:15 INFO - 'sessionrestore', 20:11:15 INFO - 'sessionrestore_no_auto_restore', 20:11:15 INFO - 'tabpaint']}, 20:11:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['a11yr', 20:11:15 INFO - 'ts_paint', 20:11:15 INFO - 'tpaint', 20:11:15 INFO - 'sessionrestore', 20:11:15 INFO - 'sessionrestore_no_auto_restore', 20:11:15 INFO - 'tabpaint']}, 20:11:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['a11yr', 20:11:15 INFO - 'ts_paint', 20:11:15 INFO - 'tpaint', 20:11:15 INFO - 'sessionrestore', 20:11:15 INFO - 'sessionrestore_no_auto_restore', 20:11:15 INFO - 'tabpaint']}, 20:11:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['tsvgx', 20:11:15 INFO - 'tsvgr_opacity', 20:11:15 INFO - 'tart', 20:11:15 INFO - 'tscrollx', 20:11:15 INFO - 'cart']}, 20:11:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:11:15 INFO - 'tsvgr_opacity', 20:11:15 INFO - 'tart', 20:11:15 INFO - 'tscrollx', 20:11:15 INFO - 'cart']}, 20:11:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:15 INFO - 'talos_options': ['--disable-e10s'], 20:11:15 INFO - 'tests': ['tp5o']}, 20:11:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:15 INFO - 'tests': ['tp5o']}, 20:11:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:15 INFO - 'talos_options': ['--disable-e10s', 20:11:15 INFO - '--xperf_path', 20:11:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:15 INFO - 'tests': ['tp5n']}, 20:11:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:15 INFO - 'talos_options': ['--xperf_path', 20:11:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:15 INFO - 'tests': ['tp5n']}}, 20:11:15 INFO - 'talos.zip': {'path': '', 20:11:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:11:15 INFO - Running post-action listener: _resource_record_post_action 20:11:15 INFO - [mozharness: 2016-10-04 03:11:15.471613Z] Finished populate-webroot step (success) 20:11:15 INFO - [mozharness: 2016-10-04 03:11:15.471722Z] Running create-virtualenv step. 20:11:15 INFO - Running pre-action listener: _resource_record_pre_action 20:11:15 INFO - Running main action method: create_virtualenv 20:11:15 INFO - Creating virtualenv /builds/slave/test/build/venv 20:11:15 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 20:11:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:11:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:11:15 INFO - Using real prefix '/usr' 20:11:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:11:16 INFO - Installing distribute.............................................................................................................................................................................................done. 20:11:18 INFO - Installing pip.................done. 20:11:18 INFO - Return code: 0 20:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:11:18 INFO - Reading from file tmpfile_stdout 20:11:18 INFO - Output received: 20:11:18 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) 20:11:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:11:18 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')]} 20:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:18 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')]} 20:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:18 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 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:18 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 20:11:18 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 20:11:18 INFO - Using env: {'DISPLAY': ':0', 20:11:18 INFO - 'HOME': '/home/cltbld', 20:11:18 INFO - 'LANG': 'en_US.UTF-8', 20:11:18 INFO - 'LANGUAGE': 'en_US:en', 20:11:18 INFO - 'LOGNAME': 'cltbld', 20:11:18 INFO - 'MAIL': '/var/mail/cltbld', 20:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:18 INFO - 'MOZ_NO_REMOTE': '1', 20:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:18 INFO - 'NO_EM_RESTART': '1', 20:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:18 INFO - 'PWD': '/builds/slave/test', 20:11:18 INFO - 'SHELL': '/bin/bash', 20:11:18 INFO - 'SHLVL': '1', 20:11:18 INFO - 'TERM': 'linux', 20:11:18 INFO - 'TMOUT': '86400', 20:11:18 INFO - 'USER': 'cltbld', 20:11:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:18 INFO - '_': '/tools/buildbot/bin/python'} 20:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:18 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 20:11:18 INFO - Cleaning up... 20:11:18 INFO - Return code: 0 20:11:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:11:18 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')]} 20:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:18 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')]} 20:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:18 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 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:18 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 20:11:18 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 20:11:18 INFO - Using env: {'DISPLAY': ':0', 20:11:18 INFO - 'HOME': '/home/cltbld', 20:11:18 INFO - 'LANG': 'en_US.UTF-8', 20:11:18 INFO - 'LANGUAGE': 'en_US:en', 20:11:18 INFO - 'LOGNAME': 'cltbld', 20:11:18 INFO - 'MAIL': '/var/mail/cltbld', 20:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:18 INFO - 'MOZ_NO_REMOTE': '1', 20:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:18 INFO - 'NO_EM_RESTART': '1', 20:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:18 INFO - 'PWD': '/builds/slave/test', 20:11:18 INFO - 'SHELL': '/bin/bash', 20:11:18 INFO - 'SHLVL': '1', 20:11:18 INFO - 'TERM': 'linux', 20:11:18 INFO - 'TMOUT': '86400', 20:11:18 INFO - 'USER': 'cltbld', 20:11:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:18 INFO - '_': '/tools/buildbot/bin/python'} 20:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:18 INFO - Downloading/unpacking psutil>=3.1.1 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 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 20:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:11:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:20 INFO - Installing collected packages: psutil 20:11:20 INFO - Running setup.py install for psutil 20:11:20 INFO - building 'psutil._psutil_linux' extension 20:11:20 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 20:11:20 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 20:11:20 INFO - building 'psutil._psutil_posix' extension 20:11:20 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 20:11:21 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 20:11:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:21 INFO - Successfully installed psutil 20:11:21 INFO - Cleaning up... 20:11:21 INFO - Return code: 0 20:11:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:11:21 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')]} 20:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:21 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')]} 20:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:21 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 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:21 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 20:11:21 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 20:11:21 INFO - Using env: {'DISPLAY': ':0', 20:11:21 INFO - 'HOME': '/home/cltbld', 20:11:21 INFO - 'LANG': 'en_US.UTF-8', 20:11:21 INFO - 'LANGUAGE': 'en_US:en', 20:11:21 INFO - 'LOGNAME': 'cltbld', 20:11:21 INFO - 'MAIL': '/var/mail/cltbld', 20:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:21 INFO - 'MOZ_NO_REMOTE': '1', 20:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:21 INFO - 'NO_EM_RESTART': '1', 20:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:21 INFO - 'PWD': '/builds/slave/test', 20:11:21 INFO - 'SHELL': '/bin/bash', 20:11:21 INFO - 'SHLVL': '1', 20:11:21 INFO - 'TERM': 'linux', 20:11:21 INFO - 'TMOUT': '86400', 20:11:21 INFO - 'USER': 'cltbld', 20:11:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:21 INFO - '_': '/tools/buildbot/bin/python'} 20:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:11:21 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 20:11:21 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 20:11:21 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 20:11:21 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 20:11:21 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 20:11:21 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 20:11:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:11:24 INFO - Installing collected packages: mozsystemmonitor 20:11:24 INFO - Running setup.py install for mozsystemmonitor 20:11:24 INFO - Successfully installed mozsystemmonitor 20:11:24 INFO - Cleaning up... 20:11:24 INFO - Return code: 0 20:11:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:24 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 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:24 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 20:11:24 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 20:11:24 INFO - Using env: {'DISPLAY': ':0', 20:11:24 INFO - 'HOME': '/home/cltbld', 20:11:24 INFO - 'LANG': 'en_US.UTF-8', 20:11:24 INFO - 'LANGUAGE': 'en_US:en', 20:11:24 INFO - 'LOGNAME': 'cltbld', 20:11:24 INFO - 'MAIL': '/var/mail/cltbld', 20:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:24 INFO - 'MOZ_NO_REMOTE': '1', 20:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:24 INFO - 'NO_EM_RESTART': '1', 20:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:24 INFO - 'PWD': '/builds/slave/test', 20:11:24 INFO - 'SHELL': '/bin/bash', 20:11:24 INFO - 'SHLVL': '1', 20:11:24 INFO - 'TERM': 'linux', 20:11:24 INFO - 'TMOUT': '86400', 20:11:24 INFO - 'USER': 'cltbld', 20:11:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:24 INFO - '_': '/tools/buildbot/bin/python'} 20:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:24 INFO - Downloading/unpacking jsonschema==2.5.1 20:11:24 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 20:11:24 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 20:11:24 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 20:11:24 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 20:11:24 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 20:11:24 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 20:11:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:11:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:11:26 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 20:11:26 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 20:11:26 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 20:11:26 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 20:11:26 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 20:11:26 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 20:11:26 INFO - Downloading functools32-3.2.3-2.tar.gz 20:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:11:26 INFO - warning: no files found matching '*.txt' 20:11:26 INFO - no previously-included directories found matching 'build' 20:11:26 INFO - no previously-included directories found matching 'dist' 20:11:26 INFO - no previously-included directories found matching '.git*' 20:11:26 INFO - Installing collected packages: jsonschema, functools32 20:11:26 INFO - Running setup.py install for functools32 20:11:26 INFO - warning: no files found matching '*.txt' 20:11:26 INFO - no previously-included directories found matching 'build' 20:11:26 INFO - no previously-included directories found matching 'dist' 20:11:26 INFO - no previously-included directories found matching '.git*' 20:11:26 INFO - Successfully installed jsonschema functools32 20:11:26 INFO - Cleaning up... 20:11:26 INFO - Return code: 0 20:11:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:26 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 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:26 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 20:11:26 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 20:11:26 INFO - Using env: {'DISPLAY': ':0', 20:11:26 INFO - 'HOME': '/home/cltbld', 20:11:26 INFO - 'LANG': 'en_US.UTF-8', 20:11:26 INFO - 'LANGUAGE': 'en_US:en', 20:11:26 INFO - 'LOGNAME': 'cltbld', 20:11:26 INFO - 'MAIL': '/var/mail/cltbld', 20:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:26 INFO - 'MOZ_NO_REMOTE': '1', 20:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:26 INFO - 'NO_EM_RESTART': '1', 20:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:26 INFO - 'PWD': '/builds/slave/test', 20:11:26 INFO - 'SHELL': '/bin/bash', 20:11:26 INFO - 'SHLVL': '1', 20:11:26 INFO - 'TERM': 'linux', 20:11:26 INFO - 'TMOUT': '86400', 20:11:26 INFO - 'USER': 'cltbld', 20:11:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:26 INFO - '_': '/tools/buildbot/bin/python'} 20:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:11:27 INFO - Cleaning up... 20:11:27 INFO - Return code: 0 20:11:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:11:27 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')]} 20:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:27 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')]} 20:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:27 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 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:27 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 20:11:27 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 20:11:27 INFO - Using env: {'DISPLAY': ':0', 20:11:27 INFO - 'HOME': '/home/cltbld', 20:11:27 INFO - 'LANG': 'en_US.UTF-8', 20:11:27 INFO - 'LANGUAGE': 'en_US:en', 20:11:27 INFO - 'LOGNAME': 'cltbld', 20:11:27 INFO - 'MAIL': '/var/mail/cltbld', 20:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:27 INFO - 'MOZ_NO_REMOTE': '1', 20:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:27 INFO - 'NO_EM_RESTART': '1', 20:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:27 INFO - 'PWD': '/builds/slave/test', 20:11:27 INFO - 'SHELL': '/bin/bash', 20:11:27 INFO - 'SHLVL': '1', 20:11:27 INFO - 'TERM': 'linux', 20:11:27 INFO - 'TMOUT': '86400', 20:11:27 INFO - 'USER': 'cltbld', 20:11:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:27 INFO - '_': '/tools/buildbot/bin/python'} 20:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:27 INFO - Downloading/unpacking blobuploader==1.2.4 20:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:29 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11:29 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 20:11:29 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 20:11:29 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 20:11:29 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 20:11:29 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 20:11:29 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 20:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:31 INFO - Downloading docopt-0.6.1.tar.gz 20:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:31 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:31 INFO - Running setup.py install for blobuploader 20:11:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:31 INFO - Running setup.py install for requests 20:11:32 INFO - Running setup.py install for docopt 20:11:32 INFO - Successfully installed blobuploader requests docopt 20:11:32 INFO - Cleaning up... 20:11:32 INFO - Return code: 0 20:11:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:32 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 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:32 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 20:11:32 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 20:11:32 INFO - Using env: {'DISPLAY': ':0', 20:11:32 INFO - 'HOME': '/home/cltbld', 20:11:32 INFO - 'LANG': 'en_US.UTF-8', 20:11:32 INFO - 'LANGUAGE': 'en_US:en', 20:11:32 INFO - 'LOGNAME': 'cltbld', 20:11:32 INFO - 'MAIL': '/var/mail/cltbld', 20:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:32 INFO - 'MOZ_NO_REMOTE': '1', 20:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:32 INFO - 'NO_EM_RESTART': '1', 20:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:32 INFO - 'PWD': '/builds/slave/test', 20:11:32 INFO - 'SHELL': '/bin/bash', 20:11:32 INFO - 'SHLVL': '1', 20:11:32 INFO - 'TERM': 'linux', 20:11:32 INFO - 'TMOUT': '86400', 20:11:32 INFO - 'USER': 'cltbld', 20:11:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:32 INFO - '_': '/tools/buildbot/bin/python'} 20:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:32 INFO - Running setup.py (path:/tmp/pip-rTTIbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:32 INFO - Running setup.py (path:/tmp/pip-_T5DjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:32 INFO - Running setup.py (path:/tmp/pip-Z4K73x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:33 INFO - Running setup.py (path:/tmp/pip-Jqs7CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:33 INFO - Running setup.py (path:/tmp/pip-kHgFD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:33 INFO - Running setup.py (path:/tmp/pip-RDCl5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:33 INFO - Running setup.py (path:/tmp/pip-m2jqY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:33 INFO - Running setup.py (path:/tmp/pip-LBjN3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:33 INFO - Running setup.py (path:/tmp/pip-v41n7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:33 INFO - Running setup.py (path:/tmp/pip-SxkRuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:33 INFO - Running setup.py (path:/tmp/pip-AIZwHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:33 INFO - Running setup.py (path:/tmp/pip-0kwNis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:33 INFO - Running setup.py (path:/tmp/pip-1HW5gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:33 INFO - Running setup.py (path:/tmp/pip-qJPFeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:33 INFO - Running setup.py (path:/tmp/pip-KDLP9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:33 INFO - Running setup.py (path:/tmp/pip-xJbsEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:33 INFO - Running setup.py (path:/tmp/pip-8Kcy1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:33 INFO - Running setup.py install for manifestparser 20:11:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:34 INFO - Running setup.py install for mozcrash 20:11:34 INFO - Running setup.py install for mozdebug 20:11:34 INFO - Running setup.py install for mozdevice 20:11:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:11:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:34 INFO - Running setup.py install for mozfile 20:11:34 INFO - Running setup.py install for mozhttpd 20:11:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:11:34 INFO - Running setup.py install for mozinfo 20:11:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:11:34 INFO - Running setup.py install for mozInstall 20:11:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:11:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:11:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:11:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:11:34 INFO - Running setup.py install for mozleak 20:11:34 INFO - Running setup.py install for mozlog 20:11:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Running setup.py install for moznetwork 20:11:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Running setup.py install for mozprocess 20:11:35 INFO - Running setup.py install for mozprofile 20:11:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Running setup.py install for mozrunner 20:11:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Running setup.py install for mozscreenshot 20:11:35 INFO - Running setup.py install for moztest 20:11:35 INFO - Running setup.py install for mozversion 20:11:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:11:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:11:35 INFO - Cleaning up... 20:11:35 INFO - Return code: 0 20:11:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:11:35 INFO - Using env: {'DISPLAY': ':0', 20:11:35 INFO - 'HOME': '/home/cltbld', 20:11:35 INFO - 'LANG': 'en_US.UTF-8', 20:11:35 INFO - 'LANGUAGE': 'en_US:en', 20:11:35 INFO - 'LOGNAME': 'cltbld', 20:11:35 INFO - 'MAIL': '/var/mail/cltbld', 20:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:35 INFO - 'MOZ_NO_REMOTE': '1', 20:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:35 INFO - 'NO_EM_RESTART': '1', 20:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:35 INFO - 'PWD': '/builds/slave/test', 20:11:35 INFO - 'SHELL': '/bin/bash', 20:11:35 INFO - 'SHLVL': '1', 20:11:35 INFO - 'TERM': 'linux', 20:11:35 INFO - 'TMOUT': '86400', 20:11:35 INFO - 'USER': 'cltbld', 20:11:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:35 INFO - '_': '/tools/buildbot/bin/python'} 20:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:36 INFO - Running setup.py (path:/tmp/pip-RAAwWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:36 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)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:36 INFO - Running setup.py (path:/tmp/pip-WS5Xyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:36 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)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:36 INFO - Running setup.py (path:/tmp/pip-38gOvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:36 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)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:36 INFO - Running setup.py (path:/tmp/pip-ylA0Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:36 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)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:36 INFO - Running setup.py (path:/tmp/pip-9pclHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:36 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)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:36 INFO - Running setup.py (path:/tmp/pip-N0F2_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:36 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)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:36 INFO - Running setup.py (path:/tmp/pip-fLVWMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:36 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)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:36 INFO - Running setup.py (path:/tmp/pip-I8DoPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:36 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)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:36 INFO - Running setup.py (path:/tmp/pip-yIMMuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:36 INFO - Running setup.py (path:/tmp/pip-SfnXha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:36 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)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:36 INFO - Running setup.py (path:/tmp/pip-5oomUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:36 INFO - Running setup.py (path:/tmp/pip-_HaJeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:37 INFO - Running setup.py (path:/tmp/pip-geptfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:37 INFO - Running setup.py (path:/tmp/pip-5Ecr3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:37 INFO - Running setup.py (path:/tmp/pip-9mn1jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:37 INFO - Running setup.py (path:/tmp/pip-hpAOmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:37 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)) 20:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:37 INFO - Running setup.py (path:/tmp/pip-swOsxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:37 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)) 20:11:37 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)) 20:11:37 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)) 20:11:37 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)) 20:11:37 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)) 20:11:37 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)) 20:11:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:40 INFO - Downloading blessings-1.6.tar.gz 20:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:11:40 INFO - Installing collected packages: blessings 20:11:40 INFO - Running setup.py install for blessings 20:11:40 INFO - Successfully installed blessings 20:11:40 INFO - Cleaning up... 20:11:40 INFO - Return code: 0 20:11:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:40 INFO - Reading from file tmpfile_stdout 20:11:40 INFO - Current package versions: 20:11:40 INFO - argparse == 1.2.1 20:11:40 INFO - blessings == 1.6 20:11:40 INFO - blobuploader == 1.2.4 20:11:40 INFO - docopt == 0.6.1 20:11:40 INFO - functools32 == 3.2.3-2 20:11:40 INFO - jsonschema == 2.5.1 20:11:40 INFO - manifestparser == 1.1 20:11:40 INFO - mozInstall == 1.12 20:11:40 INFO - mozcrash == 0.17 20:11:40 INFO - mozdebug == 0.1 20:11:40 INFO - mozdevice == 0.48 20:11:40 INFO - mozfile == 1.2 20:11:40 INFO - mozhttpd == 0.7 20:11:40 INFO - mozinfo == 0.9 20:11:40 INFO - mozleak == 0.1 20:11:40 INFO - mozlog == 3.4 20:11:40 INFO - moznetwork == 0.27 20:11:40 INFO - mozprocess == 0.23 20:11:40 INFO - mozprofile == 0.28 20:11:40 INFO - mozrunner == 6.12 20:11:40 INFO - mozscreenshot == 0.1 20:11:40 INFO - mozsystemmonitor == 0.3 20:11:40 INFO - moztest == 0.7 20:11:40 INFO - mozversion == 1.4 20:11:40 INFO - psutil == 3.1.1 20:11:40 INFO - requests == 1.2.3 20:11:40 INFO - wsgiref == 0.1.2 20:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:40 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')]} 20:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:40 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')]} 20:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:40 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 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:40 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 20:11:40 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 20:11:40 INFO - Using env: {'DISPLAY': ':0', 20:11:40 INFO - 'HOME': '/home/cltbld', 20:11:40 INFO - 'LANG': 'en_US.UTF-8', 20:11:40 INFO - 'LANGUAGE': 'en_US:en', 20:11:40 INFO - 'LOGNAME': 'cltbld', 20:11:40 INFO - 'MAIL': '/var/mail/cltbld', 20:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:40 INFO - 'MOZ_NO_REMOTE': '1', 20:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:40 INFO - 'NO_EM_RESTART': '1', 20:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:40 INFO - 'PWD': '/builds/slave/test', 20:11:40 INFO - 'SHELL': '/bin/bash', 20:11:40 INFO - 'SHLVL': '1', 20:11:40 INFO - 'TERM': 'linux', 20:11:40 INFO - 'TMOUT': '86400', 20:11:40 INFO - 'USER': 'cltbld', 20:11:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:40 INFO - '_': '/tools/buildbot/bin/python'} 20:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 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)) 20:11:41 INFO - Cleaning up... 20:11:41 INFO - Return code: 0 20:11:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:41 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 0x7f93d0245f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, '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': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', '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 20:11:41 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 20:11:41 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 20:11:41 INFO - Using env: {'DISPLAY': ':0', 20:11:41 INFO - 'HOME': '/home/cltbld', 20:11:41 INFO - 'LANG': 'en_US.UTF-8', 20:11:41 INFO - 'LANGUAGE': 'en_US:en', 20:11:41 INFO - 'LOGNAME': 'cltbld', 20:11:41 INFO - 'MAIL': '/var/mail/cltbld', 20:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:41 INFO - 'MOZ_NO_REMOTE': '1', 20:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:41 INFO - 'NO_EM_RESTART': '1', 20:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:41 INFO - 'PWD': '/builds/slave/test', 20:11:41 INFO - 'SHELL': '/bin/bash', 20:11:41 INFO - 'SHLVL': '1', 20:11:41 INFO - 'TERM': 'linux', 20:11:41 INFO - 'TMOUT': '86400', 20:11:41 INFO - 'USER': 'cltbld', 20:11:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:41 INFO - '_': '/tools/buildbot/bin/python'} 20:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:11:41 INFO - Cleaning up... 20:11:41 INFO - Return code: 0 20:11:41 INFO - Running post-action listener: _resource_record_post_action 20:11:41 INFO - Running post-action listener: _start_resource_monitoring 20:11:41 INFO - Starting resource monitoring. 20:11:41 INFO - [mozharness: 2016-10-04 03:11:41.455445Z] Finished create-virtualenv step (success) 20:11:41 INFO - [mozharness: 2016-10-04 03:11:41.456022Z] Running install step. 20:11:41 INFO - Running pre-action listener: _resource_record_pre_action 20:11:41 INFO - Running main action method: install 20:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:41 INFO - Reading from file tmpfile_stdout 20:11:41 INFO - Detecting whether we're running mozinstall >=1.0... 20:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:11:41 INFO - Reading from file tmpfile_stdout 20:11:41 INFO - Output received: 20:11:41 INFO - Usage: mozinstall [options] installer 20:11:41 INFO - Options: 20:11:41 INFO - -h, --help show this help message and exit 20:11:41 INFO - -d DEST, --destination=DEST 20:11:41 INFO - Directory to install application into. [default: 20:11:41 INFO - "/builds/slave/test"] 20:11:41 INFO - --app=APP Application being installed. [default: firefox] 20:11:41 INFO - mkdir: /builds/slave/test/build/application 20:11:41 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'] 20:11:41 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 20:11:58 INFO - Reading from file tmpfile_stdout 20:11:58 INFO - Output received: 20:11:58 INFO - /builds/slave/test/build/application/firefox/firefox 20:11:58 INFO - Running post-action listener: _resource_record_post_action 20:11:58 INFO - [mozharness: 2016-10-04 03:11:58.764493Z] Finished install step (success) 20:11:58 INFO - [mozharness: 2016-10-04 03:11:58.764829Z] Running run-tests step. 20:11:58 INFO - Running pre-action listener: _resource_record_pre_action 20:11:58 INFO - Running main action method: run_tests 20:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:11:58 INFO - Python 2.7.3 20:11:58 INFO - Return code: 0 20:11:58 INFO - grabbing minidump binary from tooltool 20:11: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')]} 20:11:58 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 0x1f46790>, '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 0x1f47690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f47b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:11:58 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 20:11:58 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 20:11:58 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 20:11:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:11:58 INFO - Return code: 0 20:11:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:11:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:11:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:11:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:11:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:11:58 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/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 20:11:58 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/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 20:11:58 INFO - Using env: {'DISPLAY': ':0', 20:11:58 INFO - 'HOME': '/home/cltbld', 20:11:58 INFO - 'LANG': 'en_US.UTF-8', 20:11:58 INFO - 'LANGUAGE': 'en_US:en', 20:11:58 INFO - 'LOGNAME': 'cltbld', 20:11:58 INFO - 'MAIL': '/var/mail/cltbld', 20:11:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:58 INFO - 'MOZ_NO_REMOTE': '1', 20:11:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:58 INFO - 'NO_EM_RESTART': '1', 20:11:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:58 INFO - 'PWD': '/builds/slave/test', 20:11:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:58 INFO - 'SHELL': '/bin/bash', 20:11:58 INFO - 'SHLVL': '1', 20:11:58 INFO - 'TERM': 'linux', 20:11:58 INFO - 'TMOUT': '86400', 20:11:58 INFO - 'USER': 'cltbld', 20:11:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1475549891.499186-2097100403', 20:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:58 INFO - '_': '/tools/buildbot/bin/python'} 20:11:58 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/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 20:11:59 INFO - mozversion application_buildid: 20161003183005 20:11:59 INFO - mozversion application_changeset: b26e668306fba754bba594572ac721bf5b0990ef 20:11:59 INFO - mozversion application_display_name: Nightly 20:11:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:11:59 INFO - mozversion application_name: Firefox 20:11:59 INFO - mozversion application_remotingname: firefox 20:11:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:11:59 INFO - mozversion application_vendor: Mozilla 20:11:59 INFO - mozversion application_version: 52.0a1 20:11:59 INFO - mozversion platform_buildid: 20161003183005 20:11:59 INFO - mozversion platform_changeset: b26e668306fba754bba594572ac721bf5b0990ef 20:11:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:11:59 INFO - mozversion platform_version: 52.0a1 20:11:59 INFO - using testdate: 1475550719 20:11:59 INFO - actual date: 1475550719 20:11:59 INFO - starting webserver on 'localhost:47952' 20:11:59 INFO - SUITE-START | Running 2 tests 20:11:59 INFO - TEST-START | dromaeo_css 20:11:59 INFO - operating with platform_type : linux_ 20:11:59 INFO - Initialising browser for dromaeo_css test... 20:11:59 INFO - TEST-INFO | started process 22097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYnS_cN/profile http://localhost:47952/getInfo.html) 20:12:03 INFO - PROCESS | 22097 | __metrics Screen width/height:1600/1200 20:12:03 INFO - PROCESS | 22097 | colorDepth:24 20:12:03 INFO - PROCESS | 22097 | Browser inner width/height: 1024/697 20:12:03 INFO - PROCESS | 22097 | __metrics 20:12:03 INFO - PROCESS | 22097 | 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" 20:12:03 INFO - PROCESS | 22097 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:12:04 INFO - PROCESS | 22097 | console.error: PushService: 20:12:04 INFO - PROCESS | 22097 | stateChangeProcessEnqueue: Error transitioning state 20:12:04 INFO - PROCESS | 22097 | UnknownError 20:12:05 INFO - TEST-INFO | 22097: exit 0 20:12:05 INFO - Browser initialized. 20:12:05 INFO - Running cycle 1/1 for dromaeo_css test... 20:12:05 INFO - TEST-INFO | started process 22180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYnS_cN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:17 INFO - PROCESS | 22180 | RSS: Main: 173555712 20:12:17 INFO - PROCESS | 22180 | 20:13:08 INFO - PROCESS | 22180 | 1475550788912 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] 20:15:19 INFO - PROCESS | 22180 | Cycle 1(1): loaded http://localhost:47952/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47952/tests/dromaeo/cssquery-ext.html) 20:15:20 INFO - PROCESS | 22180 | RSS: Main: 296456192 20:15:20 INFO - PROCESS | 22180 | 20:18:22 INFO - PROCESS | 22180 | Cycle 1(1): loaded http://localhost:47952/tests/dromaeo/cssquery-ext.html (next: http://localhost:47952/tests/dromaeo/cssquery-jquery.html) 20:18:23 INFO - PROCESS | 22180 | RSS: Main: 275386368 20:18:23 INFO - PROCESS | 22180 | 20:21:25 INFO - PROCESS | 22180 | Cycle 1(1): loaded http://localhost:47952/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47952/tests/dromaeo/cssquery-mootools.html) 20:21:25 INFO - PROCESS | 22180 | RSS: Main: 256315392 20:21:25 INFO - PROCESS | 22180 | 20:24:27 INFO - PROCESS | 22180 | Cycle 1(1): loaded http://localhost:47952/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47952/tests/dromaeo/cssquery-prototype.html) 20:24:28 INFO - PROCESS | 22180 | RSS: Main: 213458944 20:24:28 INFO - PROCESS | 22180 | 20:27:31 INFO - PROCESS | 22180 | Cycle 1(1): loaded http://localhost:47952/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47952/tests/dromaeo/cssquery-yui.html) 20:27:31 INFO - PROCESS | 22180 | RSS: Main: 214409216 20:27:31 INFO - PROCESS | 22180 | 20:30:34 INFO - PROCESS | 22180 | Cycle 1(1): loaded http://localhost:47952/tests/dromaeo/cssquery-yui.html (next: http://localhost:47952/tests/dromaeo/cssquery-dojo.html) 20:30:34 INFO - PROCESS | 22180 | RSS: Main: 284205056 20:30:35 INFO - PROCESS | 22180 | 20:30:35 INFO - PROCESS | 22180 | __start_tp_report 20:30:35 INFO - PROCESS | 22180 | _x_x_mozilla_page_load 20:30:35 INFO - PROCESS | 22180 | _x_x_mozilla_page_load_details 20:30:35 INFO - PROCESS | 22180 | |i|pagename|runs| 20:30:35 INFO - PROCESS | 22180 | |0;dojo.html;2983.2690990707274;3010.3226773975857;3014.2615059310474;3040.817550946942;3058.2201538607665;5064.468230835764;5152.278680984665;5218.791248350061;5219.92170117448;5280.128778751511;5112.514311140436;5179.14544100223;5195.714235717034;5297.523222909937;5329.094054010818;4765.046990601876;4780.737059461728;4810.927836082462;4866.999999999991;4895.31465594817;4759.911916220767;4764;4820.517948205169;4850.102730994759;4901.436334821506;4798.664093513456;4824.324594556747;4833.468318484964;4833.589144922686;4897.583705385029;4675.719456832601;4724.173269677827;4735.360726301974;4800.495947925488;4840.419149702023;4770.045990801854;4774.164521208774;4782.23484242523;4829.951700482985;4857.781399837016;5194.766235519411;5198.16829307309;5238;5243.842684719426;5251.396089449686;5381.811636592701;5448.727563621803;5575.275214222125;5576.052071147915;5587.078132108198;5638.40796716343;5661.2357331760095;5712.457316554921;5718.456746609066;5720.8855822883725;5262.263283140325;5266.973665131688;5267.341582302212;5269.235960785664;5269.288646032736;5541.639793413416;5598.608097433141;5777.104548794943;5778.739956701958;5842.970785146047;5359.624826262124;5398.64908780928;5400.135978243541;5401.02781499326;5472.50747432733;5430.728463576806;5477.698726570077;5482.890342193134;5482.945170548323;5485.204645326406;5374.27447294618;5421.185566753522;5467.890642187134;5479.424660410679;5535.6955367454375;5427.077396842467;5540;5562.860928476821;5612.522935550524;5679.403662615366;4367.759773212504;4375.628071613948;4378.387025816388;4408.53710360414;4416.138852923649;3878.7284890057426;3888.0279930017496;3898.0449789801114;3939.862104826317;3942.1130245695063;5152.948470515247;5350.117230656976;5357.464253574689;5359.544438722674;5364.8122315718765;5486.945130548724;5492.340919089655;5557.138643510262;5570.41510641385;5655.886882262332;5234.26720259164;5264.947350526446;5283.603729720209;5285;5286.60350473716;4866.270059491034;4867.780949857194;4877.853664390074;4880.243562247857;4880.341153944243;5496.7526461309335;5542;5693.800716974886;5745.396733342939;5748.6838223898085;5643.435656434488;5644.971775141098;5647;5652.7738890443925;5699.971500142473;5749.798757043483;5759.04975679025;5765.221695071112;5774.913376299275;5777.335606405317;5337.932413517235;5367.194920761917;5485.6982865942755;5533.170024496358;5539.501444869981;5617.662940223599;5657.8019769307875;5660.320761508646;5717.313922329347;5739.9139012914;5524.06090964529;5531.115021596525;5534.7509362078;5534.833954981357;5535.363433205233;5350.357957045024;5397.865053373697;5415.566754659539;5460.180972854104;5584.497395234448;5345.33183352081;5405.324334458192;5405.351357837085;5454.481824226692;5457.426970168075;5473.261109750133;5475.5072043516275;5479.808206712746;5484.61607687474;5492.450754924475;5202.843914682566;5261.657992230493;5263.131583288715;5287.68273903567;5333.040052790535 20:30:35 INFO - PROCESS | 22180 | |1;ext.html;567.86371270895;589.2251689028926;601.7713268957796;603.4960807725549;626.8902941985153;31347.84326078369;32240.355192896128;42041.369379459255;42962.78518607403;43050.35424468636;41644;46052.76973615127;46154;46176.53823461764;46200.30699539501;8854;9000.954995225014;9001.684941027066;9010.954945225265;9019.909800902005;8075.5154690718455;8296.460730052557;8928.24109950655;10588.3646981181;10850;11002.284851484668;11055;11074.612388566402;11075.446227688582;11077.833832492519;10778.514966826511;10831.620893268777;10839.945800271027;10840.67477975662;10841.13270938323;10482.737931551696;10555.6749623869;10557.472126393726;10563.47182640865;10564.78870422595;42709;43281.13437731259;43289.78355108236;43327.35008974868;43361.56638433607;3399.762016658835;3413.8805141819917;3488.3895318319446;3510.7893526388243;3672.9348488938444;31475.213119671964;31622;31644.36711265785;31920.680793192005;33134.6686533134;4213.536510983789;4263.424437700933;4298.26929421999;4329.588689074533;4375.16871794358;341991;343701;344295;344465;344503;56592.71703641456;56721.43278567244;56966;57010.71494642583;57053.42946570481;36110.277794443966;36689.81655091707;36951;38853.805730971166;38901;16243.269052892412;16517.834821651628;16525.173741312887;16534.173291335625;16537.503874883772;10900.40047797363;12101.394930253453;12238;12262.448189831479;12283.14018018748;16439.506814795575;18455.354062607745;18792.53018674544;19148.425547233604;19618.705719413934;7046.330598593126;7059.647017649199;7210.978832674776;7370.963145184347;7451.254874512505;916.2166347772692;979.9657012004545;1029.7374169586708;1105.4362275239525;1116.268843907242;28852;28891.422171556453;28924.132276031753;29037.274068148043;29077.854610726812;1058.0688993685508;1059.6926891201465;1104.0670633314837;1115.3475216997986;1135.8580177477816;15130.319135638923;15970.520884373487;15996.600084997968;16067.357305707874;16240;532281;536534;538164;538383;538504;56237.718811405684;56671;56723;56744.43255567474;56813;1198.4606926882936;1214.1743614342156;1299.175023859837;1319.228251472899;1345.3273363318538;27860.30349241285;29154;29942.550861736654;30343.84828075934;30549.847250763603;48328;48703.756481218785;48842.51157488522;48889.266661000824;48981.75509122432;379549;383294;383413;384740.83110025857;385273;25277.62083568711;25693.486130277663;25951.22146335613;25985.350366240997;27143.321416964733;45087.29476231305;45586;45730.771346143054;45923.540764593265;46353;38531.80734096312;38629.4205586922;39073.804630976665;40479.79760101181;40809.59190408058;38372.424413633256;38530;39341.803290983364;39564;40727.79636101801;34466.138346541535;35192;35300.117497062776;35424;38148.80925595354;32911.835440822644;34925.30149396947;35201;36096;36097.917062488166;25502.872485637454;25953.740462595888;25970;26185.73814261833;26241.343966400993 20:30:35 INFO - PROCESS | 22180 | |2;jquery.html;367.9779213247207;391.33473095737236;391.5966554448918;401.19360086226686;419.76283399879065;13347.399367028484;18721;19315;20153.697694534556;20295.59408811823;18177.182026808794;18992.810071899275;19139.468842492603;19173.137208825603;19187.13657885395;5597.160425936112;5911.142884281777;5914.852128696795;5915.319738230094;5921;5666.291713535808;5690.374058853523;5742.0238559445;5743.885122297552;5764.452377024197;5713.143028545731;5713.74288157034;5716.7141642917895;5720.542356611482;5723.656580605177;5591.6365436246715;5698.6865722385255;5750;5770.740316685738;5777.45114214149;5188.429272779991;5197.480251974772;5202.92195617066;5203;5203.4016088149965;22825.201117960958;22923.197688081003;22955.08179672811;23073.76926230733;23111.88444057769;2379.7858192762733;2476.2199907029226;2492.476579918219;2585.6380106784877;2873.3391319996517;13923.651908702364;14211.50259740904;14263.714725705428;14564.490242841555;14944.925275373553;1871.2514994002509;1895;1944.9027548622653;1973.6250112478726;1994.1524851937868;54397;80420.59789701072;82438.58780706118;83451.58274208651;85025;10229.539670714836;10562.89437105619;10712.303700259457;11056.226064175431;11604.76790464186;14690.045147065406;15188.316525756367;15188.848111518964;15204.847951520564;15216.163111029;8166.83666326682;8169.591520423955;8242.752717418487;8334.249917507454;8349.4155409122;7738.651760670783;7754.263344982218;7872.291493765474;7997.440179187517;8025.23760242776;6346;6498.480121590262;6521.673916304166;6613.503987200883;6727.29363416844;1885.8397036252072;1892.098441066719;1919.1459800388973;1931.430228082719;1949.9122539485757;867.9392442528963;929.5073610986188;970.4759429907912;983.9163671087895;1020.3775696824931;17424.303027878745;17920.283188672307;18008.279668813364;18054.3680971168;18791.81208187928;962.6005207838808;964;986.7730422002836;996.531630133836;1051.8685164354456;10222.335548189492;10671.786564268827;10703.73240668974;10723.356598604109;10800.135989120852;420434.62828632933;424592;424604;439064;442857;79372.6031369851;80265;82819.5859020701;83957.58021209855;84103.5794821022;995.193892946701;1034.343192073039;1063.803196408667;1065.7974984752873;1069.5935544493043;15824.129672867643;16283.837161628233;16553.586160345607;16687.165641718108;16976.490705278862;31837.6816231844;37934.43098353582;38214.617853822216;39850.800745996086;39946.800265998485;51733.482665172865;51869.7406512965;52118;52220.73889630527;53487.8488973773;7845.097813751491;7975.202479752211;7998.400119990907;8157.143499932422;8183.63173657175;11158.274712143684;12640;12703.618891433272;13012.349382531025;13087.934560327138;10482.63310784119;10918.12654987615;11133.109351251718;11172.553097875994;11625;10512.316699414514;10852.837207441737;11041.39272339997;11124.61063862761;11239.719007024889;10672.89327106719;10833;10906.745724241497;11093.278936869077;11269.211155219384;8135.593220338841;8347.332213422791;8490.702825401082;8525.019622743464;8623.65505379803;8859.867101993346;10558.788824223318;10636.468176590985;10774.622888198875;11413 20:30:35 INFO - PROCESS | 22180 | |3;mootools.html;1364.2632978191778;1465.1428914085259;1518.5975716435146;1627.9104649244293;1792.0949920290243;7903.881441778378;8821.558922053895;8988.865167022483;9046.09539046096;9332.813343733122;9130.589123489442;9173.724788256362;9175.95412022939;9178.036306187854;9191.35660503765;2302.6776251324786;2346.483773569812;2349.530093981202;2354.682117914085;2355.764423557639;2209.3371988403496;2214.202886960693;2281.2927992322434;2285.2915596165158;2288.370698058039;2274.920377786778;2296.873671948042;2298.0463107810237;2325.8720770357622;2330.860148391102;2228.242397584821;2244.0911430870524;2255.041607316884;2258.2660635293514;2259.1302348595746;2215.080741492279;2233.542123864604;2234.843560950734;2253.605619016682;2256.9548609027893;9170.266378689756;9212.861807072899;9232.584533696;9246.35275530713;9255.398399104037;5109.9489005109845;5127.641065125443;5262.973685131588;5269.6311258211945;5270.868228294285;3378.712809411203;3462.1517728156764;3488.4069708149677;3537.9292414151573;3542.5394698689006;1066.9946650266777;1108.4457771114444;1115.8549388579513;1116.5087361560968;1117.1398023521842;12769.233845969178;12816.615501534876;12885.033622478351;12937;12953.546625868144;4320.509424248629;4419.204543182193;4487.640988720895;4545.681802273809;4551.635869130461;9968.700938971697;9971.05274998874;9979.301448898508;9992.550335234931;10004;5136.357955255593;5143.3570803649545;5154.7164905929785;5159;5162.97418512905;4266.445362102907;4368.322909948963;4728.621710263171;4806.423229212517;4880.487548807395;3772.2078363543415;3954.663853572421;4003.7597744135446;4052.1085361220485;4064.4106604542176;1196.581196581207;1224.0819385460904;1227.9877201227873;1231.0643910627807;1250.7498500299976;854.4747625488598;872.3108744092096;889.177510802518;900.5182227508252;925.0980294213089;5649.774009039675;5660.471672648444;5687.146927960839;5691.8292451226525;5769.394213607511;932.8181004704018;945.2768631996528;964.4165280005636;984.9950750246346;1030.9020892749197;3696.8706095286534;3760.041189496661;3776.8866933992026;3782.7541209821275;3906.43356713275;10962.835557466644;11365.886341136484;11373.090152787758;11385.601503947488;11433.771324573461;11263.211575189822;11265.718357040976;11270.380129092815;11274.323540587427;11277.32336059839;7843.764687059397;8138.348932085537;8349.66601335952;8509.361797865186;8522.275606573387;5535.335759708861;5562.415946325577;5595.832125036255;5650.152477128464;5732.684702341411;9604.95197524008;9848.310618256653;10245.948770256102;10368.326058806153;10487.580496780043;10496.107830834464;10578.8413173804;10682.305650132717;10687.732806679895;10837.891621083689;7304.7078116876855;7473.551586904803;7539.9246007541415;7544.735934242275;7618.276263754934;7888.960555197187;8641.956790216009;8663.696770612998;8953.059928707393;8985.236254918405;7378.557286562609;7489.28851759082;7595.202503737028;7741.264579864904;7741.92258077412;7325.706971721072;7621.390288776774;7660.425468089804;7679.808004799701;7884.369250459835;6513.185851768529;6608.4052435281055;6610.3720146586;6616.073749674953;6622.933770662425;4819.831305904277;4869.537393947569;4933.333999909966;4936.802527898843;4963.950360496348;5006.599472042155;5065.924011139762;5093.490650934877;5175.9741201293755;5186.481351864934 20:30:35 INFO - PROCESS | 22180 | |4;prototype.html;334.20626013218606;344.6949449736982;345.1113383038676;351.97888126712417;352.8641473032882;5329.294625719771;5341.759620817063;5352.143657014878;5357.732113394324;5388.649737767042;5211.661242019276;5215.139501982168;5227.372715274172;5328.227407025979;5336.893262134765;3929.607039296069;4052.1490486997764;4061.1065565575527;4141.337386018237;4175.248455278064;4160.271952408331;4160.667146628278;4170.582941705836;4171.80979985507;4188.602082802129;4123.9381409278885;4130.834766609347;4152.231837110145;4154;4154.729942553739;3931.724779265467;3944.1322908959983;4105.651019663333;4105.932457561025;4171.520275168334;3652.3608368535665;3652.6850333879784;3674.540682414698;3680.3743363628246;3691.187938653519;5076.898462030738;5095.847124586268;5097.617678674114;5141.640085194038;5178.533931946143;4425.513193548707;4606.170889239936;4686.484486706459;4687.10944920464;4727.456342520585;5409.215663728737;5434.206711785101;5438.320209973754;5443.475826768472;5445.727713614304;3922.431027588959;3933.1543718100747;3936.940945885814;3945.3687410014545;3962.0689138052535;5546.362168350651;5637.323521177444;5640.774369025234;5642.12547055203;5756.913646295309;4023.376376661622;4034.5561988181275;4040.9595904040584;4055.8986025349604;4056.878293651136;4098.4876890388705;4107.342825147962;4118.897027574275;4135.17296540687;4137.958620413818;4597.3333866589155;4640.2024670691635;4662.230731929261;4714.787834547454;4722.52774722525;5475.644083134664;5486.558481475705;5515.806946756844;5524.696141712245;5542.39033706292;1413.2156653057652;1431.4918204037417;1433.3979728514048;1434.3330351386655;1435.3253970633784;856.6402111113347;910.886139232596;924.3714274293545;941.773974246176;943.7499062748377;5151;5170.870728231825;5355.196720491879;5363.973180134074;5372.973135134299;5637.379888212294;5706.3722990471015;5708.257926469615;5726.656400615976;5752.856178595485;5082.364704411949;5372.140457526777;5387.568994480433;5408.378036525771;5408.486193811582;2980.6125203723377;3017.8641961111803;3025.2285667154733;3029.4546981543094;3030.7876849260474;5875.236219291465;5881.647101173858;5883.941160588425;5892.5285977122585;5899.292084949833;5637.520810731134;5798.159266906359;5808.332041815161;5811.4479124483105;5825.854353641193;5823.708814559255;5857.355690874;5861.38811826751;5867.442592953663;5879.265091863517;5393.487618676219;5637.5489960802215;5648.435156484319;5666.744996475251;5711.314642242957;5586.664800112007;5591.8881622368135;5593.440655934537;5603.943960560342;5614.242077319673;5781.785824976802;5794;5820.359760426434;5821.864736376366;5834.854128646818;3922.2939870823525;4036.172584620087;4045.37296719009;4077.8776636700945;4085.652719518874;5603.859903502445;5605.906848164569;5623.493885550321;5626.943730562642;5640.915386269127;5555.916661250165;5574.944250557604;5580.832575022756;5585.045234168008;5594.944050559605;5312.5218730314455;5496.444153468657;5521.4478552144465;5524.33707955048;5526.171074338881;5461.756713555032;5463.153211252262;5464.644798088111;5488.530161427294;5528.502434780889;5319.973400132974;5359.383670877899;5476.616636835383;5558.749856256559;5576.275084239023;5439.292891924025;5448.509634132947;5453.282216101915;5469.097598896296;5469.453054694499 20:30:35 INFO - PROCESS | 22180 | |5;yui.html;739.334598861025;742.5730205132049;774.4733581164809;781.8827175923607;799.9000124984377;14471.421143154274;15268.541943741679;15339.769903451457;15362.54342772877;15369.846301536982;15392.384304627829;15491.225438728075;15519.767203491929;15521.301541430634;15552.68894622107;648.9870202595945;651.4397618048474;759;760.467672629159;763.8090477380655;765.4947734495234;769.86142494351;769.8768197088467;770.4029377232662;775.5385545600359;807.5316316536424;809.9433039687224;810.7770363150122;811.059171361221;811.1969150540981;664.1565212180528;678.1556961582861;680.5542369747823;682.9931700682979;805.017878188609;574.8591595059196;584.9181114643953;585.5081731345648;589.8525368657836;592.9407059294036;14181.716365672628;14216.786748198785;14223.146611203361;14226.217558034305;14236.928815355961;13431;13559.25424101674;13740.312984350743;14262.500812471513;14595.78106328406;12231.449584768707;12304.384780760925;12405.565805196866;12636;12687.619371418872;4340.8697739067875;4362.650987920959;4454.665900057476;4519.909601807945;4532.954670453286;75481.62259188724;76114.61942690307;76827;76990;78193.60903195504;11056.502457389437;11104.888951110546;11373.31760094397;11377.203595748384;11444.427778611036;21192.894035530033;21204.25785097514;21345.35963921085;21378.78621213799;21420.678689819666;8065.798355041054;8127;8138.633761480747;8219.342452603778;8275.379346549033;4253.787310634518;4428.800703968329;4455.844045458458;4526.388937493396;4594.5864872161665;3529.7176225901867;3672.045268230226;3672.3940549809518;3675.4854320395166;3676.485292059114;631.9083732858802;636.0903907412352;638.3170008091298;642.1491523731075;648.2545073165898;599.7481057955582;654.7577396363376;657.2901266632026;669.3172963577124;685.116200101873;8014.559199243981;9191.494467804336;9269.768255793524;9336.346455748168;9545.618175272912;641.2049059166693;642.4442856928723;642.8553575445487;652.2759736692268;657.4280376072752;3347.4811404232382;3450.879219227315;4091.3453847384276;4290.806913688892;4316.5467625899455;80178.19821801824;119153;122379;127612;128924;101453;105140;105639.47180264049;109195.0747634118;109411.45294273637;93508.53245733863;93973;94927;95403.52298238465;97991.51004244933;7848.293653570978;7950.801229969297;8181.427300088937;8191.713290034821;8468.957655211685;36344.27311453809;36507.634923650425;39038.804805975786;46614.76692616515;48167.277490838365;48051.5194848061;49316.75341623269;49960;64745.676271618344;76947.230527694;13077.260667478075;13086.280254586089;13142.868571314164;13200.471981120647;13247.337633118499;13909.721805564035;14395.496157634432;15350;15383.30775115145;15679.451219207273;13781.931090344484;15026.6994660104;15048.097114172746;15067.924660376628;15288.847111529187;12627.74744505123;13636.250006249355;13652.522161724291;13827.792583111463;14637.707245855236;12259.693507662023;12936;12938.611841644766;13018.80471792905;14376.353064112349;10988.615398461016;11557.942210288895;11939.582114625946;12338.259704417764;12352.320622365856;12223.205491643015;12386.938065309616;12388.380580971096;12432.502699892264;12544.560940367044 20:30:35 INFO - PROCESS | 22180 | __end_tp_report 20:30:35 INFO - PROCESS | 22180 | __start_cc_report 20:30:35 INFO - PROCESS | 22180 | _x_x_mozilla_cycle_collect,1086 20:30:35 INFO - PROCESS | 22180 | __end_cc_report 20:30:35 INFO - PROCESS | 22180 | __startTimestamp1475551834997__endTimestamp 20:30:35 INFO - PROCESS | 22180 | 20:30:35 INFO - PROCESS | 22180 | ------- Summary: start ------- 20:30:35 INFO - PROCESS | 22180 | Number of tests: 6 20:30:35 INFO - PROCESS | 22180 | 20:30:35 INFO - PROCESS | 22180 | [#0] dojo.html Cycles:165 Average:5194.65 Median:5359.62 stddev:563.81 (10.5%) stddev-sans-first:538.19 20:30:35 INFO - PROCESS | 22180 | Values: 2983.3 3010.3 3014.3 3040.8 3058.2 5064.5 5152.3 5218.8 5219.9 5280.1 5112.5 5179.1 5195.7 5297.5 5329.1 4765.0 4780.7 4810.9 4867.0 4895.3 4759.9 4764.0 4820.5 4850.1 4901.4 4798.7 4824.3 4833.5 4833.6 4897.6 4675.7 4724.2 4735.4 4800.5 4840.4 4770.0 4774.2 4782.2 4830.0 4857.8 5194.8 5198.2 5238.0 5243.8 5251.4 5381.8 5448.7 5575.3 5576.1 5587.1 5638.4 5661.2 5712.5 5718.5 5720.9 5262.3 5267.0 5267.3 5269.2 5269.3 5541.6 5598.6 5777.1 5778.7 5843.0 5359.6 5398.6 5400.1 5401.0 5472.5 5430.7 5477.7 5482.9 5482.9 5485.2 5374.3 5421.2 5467.9 5479.4 5535.7 5427.1 5540.0 5562.9 5612.5 5679.4 4367.8 4375.6 4378.4 4408.5 4416.1 3878.7 3888.0 3898.0 3939.9 3942.1 5152.9 5350.1 5357.5 5359.5 5364.8 5486.9 5492.3 5557.1 5570.4 5655.9 5234.3 5264.9 5283.6 5285.0 5286.6 4866.3 4867.8 4877.9 4880.2 4880.3 5496.8 5542.0 5693.8 5745.4 5748.7 5643.4 5645.0 5647.0 5652.8 5700.0 5749.8 5759.0 5765.2 5774.9 5777.3 5337.9 5367.2 5485.7 5533.2 5539.5 5617.7 5657.8 5660.3 5717.3 5739.9 5524.1 5531.1 5534.8 5534.8 5535.4 5350.4 5397.9 5415.6 5460.2 5584.5 5345.3 5405.3 5405.4 5454.5 5457.4 5473.3 5475.5 5479.8 5484.6 5492.5 5202.8 5261.7 5263.1 5287.7 5333.0 20:30:35 INFO - PROCESS | 22180 | 20:30:35 INFO - PROCESS | 22180 | [#1] ext.html Cycles:180 Average:57241.19 Median:35250.56 stddev:113883.41 (323.1%) stddev-sans-first:114123.39 20:30:35 INFO - PROCESS | 22180 | Values: 567.9 589.2 601.8 603.5 626.9 31347.8 32240.4 42041.4 42962.8 43050.4 41644.0 46052.8 46154.0 46176.5 46200.3 8854.0 9001.0 9001.7 9011.0 9019.9 8075.5 8296.5 8928.2 10588.4 10850.0 11002.3 11055.0 11074.6 11075.4 11077.8 10778.5 10831.6 10839.9 10840.7 10841.1 10482.7 10555.7 10557.5 10563.5 10564.8 42709.0 43281.1 43289.8 43327.4 43361.6 3399.8 3413.9 3488.4 3510.8 3672.9 31475.2 31622.0 31644.4 31920.7 33134.7 4213.5 4263.4 4298.3 4329.6 4375.2 341991.0 343701.0 344295.0 344465.0 344503.0 56592.7 56721.4 56966.0 57010.7 57053.4 36110.3 36689.8 36951.0 38853.8 38901.0 16243.3 16517.8 16525.2 16534.2 16537.5 10900.4 12101.4 12238.0 12262.4 12283.1 16439.5 18455.4 18792.5 19148.4 19618.7 7046.3 7059.6 7211.0 7371.0 7451.3 916.2 980.0 1029.7 1105.4 1116.3 28852.0 28891.4 28924.1 29037.3 29077.9 1058.1 1059.7 1104.1 1115.3 1135.9 15130.3 15970.5 15996.6 16067.4 16240.0 532281.0 536534.0 538164.0 538383.0 538504.0 56237.7 56671.0 56723.0 56744.4 56813.0 1198.5 1214.2 1299.2 1319.2 1345.3 27860.3 29154.0 29942.6 30343.8 30549.8 48328.0 48703.8 48842.5 48889.3 48981.8 379549.0 383294.0 383413.0 384740.8 385273.0 25277.6 25693.5 25951.2 25985.4 27143.3 45087.3 45586.0 45730.8 45923.5 46353.0 38531.8 38629.4 39073.8 40479.8 40809.6 38372.4 38530.0 39341.8 39564.0 40727.8 34466.1 35192.0 35300.1 35424.0 38148.8 32911.8 34925.3 35201.0 36096.0 36097.9 25502.9 25953.7 25970.0 26185.7 26241.3 20:30:35 INFO - PROCESS | 22180 | 20:30:35 INFO - PROCESS | 22180 | [#2] jquery.html Cycles:180 Average:26616.75 Median:16102.83 stddev:70973.18 (440.7%) stddev-sans-first:71144.92 20:30:35 INFO - PROCESS | 22180 | Values: 368.0 391.3 391.6 401.2 419.8 13347.4 18721.0 19315.0 20153.7 20295.6 18177.2 18992.8 19139.5 19173.1 19187.1 5597.2 5911.1 5914.9 5915.3 5921.0 5666.3 5690.4 5742.0 5743.9 5764.5 5713.1 5713.7 5716.7 5720.5 5723.7 5591.6 5698.7 5750.0 5770.7 5777.5 5188.4 5197.5 5202.9 5203.0 5203.4 22825.2 22923.2 22955.1 23073.8 23111.9 2379.8 2476.2 2492.5 2585.6 2873.3 13923.7 14211.5 14263.7 14564.5 14944.9 1871.3 1895.0 1944.9 1973.6 1994.2 54397.0 80420.6 82438.6 83451.6 85025.0 10229.5 10562.9 10712.3 11056.2 11604.8 14690.0 15188.3 15188.8 15204.8 15216.2 8166.8 8169.6 8242.8 8334.2 8349.4 7738.7 7754.3 7872.3 7997.4 8025.2 6346.0 6498.5 6521.7 6613.5 6727.3 1885.8 1892.1 1919.1 1931.4 1949.9 867.9 929.5 970.5 983.9 1020.4 17424.3 17920.3 18008.3 18054.4 18791.8 962.6 964.0 986.8 996.5 1051.9 10222.3 10671.8 10703.7 10723.4 10800.1 420434.6 424592.0 424604.0 439064.0 442857.0 79372.6 80265.0 82819.6 83957.6 84103.6 995.2 1034.3 1063.8 1065.8 1069.6 15824.1 16283.8 16553.6 16687.2 16976.5 31837.7 37934.4 38214.6 39850.8 39946.8 51733.5 51869.7 52118.0 52220.7 53487.8 7845.1 7975.2 7998.4 8157.1 8183.6 11158.3 12640.0 12703.6 13012.3 13087.9 10482.6 10918.1 11133.1 11172.6 11625.0 10512.3 10852.8 11041.4 11124.6 11239.7 10672.9 10833.0 10906.7 11093.3 11269.2 8135.6 8347.3 8490.7 8525.0 8623.7 8859.9 10558.8 10636.5 10774.6 11413.0 20:30:35 INFO - PROCESS | 22180 | 20:30:35 INFO - PROCESS | 22180 | [#3] mootools.html Cycles:180 Average:5798.50 Median:4875.01 stddev:3407.33 (69.9%) stddev-sans-first:3400.59 20:30:35 INFO - PROCESS | 22180 | Values: 1364.3 1465.1 1518.6 1627.9 1792.1 7903.9 8821.6 8988.9 9046.1 9332.8 9130.6 9173.7 9176.0 9178.0 9191.4 2302.7 2346.5 2349.5 2354.7 2355.8 2209.3 2214.2 2281.3 2285.3 2288.4 2274.9 2296.9 2298.0 2325.9 2330.9 2228.2 2244.1 2255.0 2258.3 2259.1 2215.1 2233.5 2234.8 2253.6 2257.0 9170.3 9212.9 9232.6 9246.4 9255.4 5109.9 5127.6 5263.0 5269.6 5270.9 3378.7 3462.2 3488.4 3537.9 3542.5 1067.0 1108.4 1115.9 1116.5 1117.1 12769.2 12816.6 12885.0 12937.0 12953.5 4320.5 4419.2 4487.6 4545.7 4551.6 9968.7 9971.1 9979.3 9992.6 10004.0 5136.4 5143.4 5154.7 5159.0 5163.0 4266.4 4368.3 4728.6 4806.4 4880.5 3772.2 3954.7 4003.8 4052.1 4064.4 1196.6 1224.1 1228.0 1231.1 1250.7 854.5 872.3 889.2 900.5 925.1 5649.8 5660.5 5687.1 5691.8 5769.4 932.8 945.3 964.4 985.0 1030.9 3696.9 3760.0 3776.9 3782.8 3906.4 10962.8 11365.9 11373.1 11385.6 11433.8 11263.2 11265.7 11270.4 11274.3 11277.3 7843.8 8138.3 8349.7 8509.4 8522.3 5535.3 5562.4 5595.8 5650.2 5732.7 9605.0 9848.3 10245.9 10368.3 10487.6 10496.1 10578.8 10682.3 10687.7 10837.9 7304.7 7473.6 7539.9 7544.7 7618.3 7889.0 8642.0 8663.7 8953.1 8985.2 7378.6 7489.3 7595.2 7741.3 7741.9 7325.7 7621.4 7660.4 7679.8 7884.4 6513.2 6608.4 6610.4 6616.1 6622.9 4819.8 4869.5 4933.3 4936.8 4964.0 5006.6 5065.9 5093.5 5176.0 5186.5 20:30:35 INFO - PROCESS | 22180 | 20:30:35 INFO - PROCESS | 22180 | [#4] prototype.html Cycles:180 Average:4652.78 Median:5361.68 stddev:1364.12 (25.4%) stddev-sans-first:1328.88 20:30:35 INFO - PROCESS | 22180 | Values: 334.2 344.7 345.1 352.0 352.9 5329.3 5341.8 5352.1 5357.7 5388.6 5211.7 5215.1 5227.4 5328.2 5336.9 3929.6 4052.1 4061.1 4141.3 4175.2 4160.3 4160.7 4170.6 4171.8 4188.6 4123.9 4130.8 4152.2 4154.0 4154.7 3931.7 3944.1 4105.7 4105.9 4171.5 3652.4 3652.7 3674.5 3680.4 3691.2 5076.9 5095.8 5097.6 5141.6 5178.5 4425.5 4606.2 4686.5 4687.1 4727.5 5409.2 5434.2 5438.3 5443.5 5445.7 3922.4 3933.2 3936.9 3945.4 3962.1 5546.4 5637.3 5640.8 5642.1 5756.9 4023.4 4034.6 4041.0 4055.9 4056.9 4098.5 4107.3 4118.9 4135.2 4138.0 4597.3 4640.2 4662.2 4714.8 4722.5 5475.6 5486.6 5515.8 5524.7 5542.4 1413.2 1431.5 1433.4 1434.3 1435.3 856.6 910.9 924.4 941.8 943.7 5151.0 5170.9 5355.2 5364.0 5373.0 5637.4 5706.4 5708.3 5726.7 5752.9 5082.4 5372.1 5387.6 5408.4 5408.5 2980.6 3017.9 3025.2 3029.5 3030.8 5875.2 5881.6 5883.9 5892.5 5899.3 5637.5 5798.2 5808.3 5811.4 5825.9 5823.7 5857.4 5861.4 5867.4 5879.3 5393.5 5637.5 5648.4 5666.7 5711.3 5586.7 5591.9 5593.4 5603.9 5614.2 5781.8 5794.0 5820.4 5821.9 5834.9 3922.3 4036.2 4045.4 4077.9 4085.7 5603.9 5605.9 5623.5 5626.9 5640.9 5555.9 5574.9 5580.8 5585.0 5594.9 5312.5 5496.4 5521.4 5524.3 5526.2 5461.8 5463.2 5464.6 5488.5 5528.5 5320.0 5359.4 5476.6 5558.7 5576.3 5439.3 5448.5 5453.3 5469.1 5469.5 20:30:35 INFO - PROCESS | 22180 | 20:30:35 INFO - PROCESS | 22180 | [#5] yui.html Cycles:180 Average:20519.70 Median:4272.30 stddev:30422.78 (712.1%) stddev-sans-first:30471.87 20:30:35 INFO - PROCESS | 22180 | Values: 739.3 742.6 774.5 781.9 799.9 14471.4 15268.5 15339.8 15362.5 15369.8 15392.4 15491.2 15519.8 15521.3 15552.7 649.0 651.4 759.0 760.5 763.8 765.5 769.9 769.9 770.4 775.5 807.5 809.9 810.8 811.1 811.2 664.2 678.2 680.6 683.0 805.0 574.9 584.9 585.5 589.9 592.9 14181.7 14216.8 14223.1 14226.2 14236.9 13431.0 13559.3 13740.3 14262.5 14595.8 12231.4 12304.4 12405.6 12636.0 12687.6 4340.9 4362.7 4454.7 4519.9 4533.0 75481.6 76114.6 76827.0 76990.0 78193.6 11056.5 11104.9 11373.3 11377.2 11444.4 21192.9 21204.3 21345.4 21378.8 21420.7 8065.8 8127.0 8138.6 8219.3 8275.4 4253.8 4428.8 4455.8 4526.4 4594.6 3529.7 3672.0 3672.4 3675.5 3676.5 631.9 636.1 638.3 642.1 648.3 599.7 654.8 657.3 669.3 685.1 8014.6 9191.5 9269.8 9336.3 9545.6 641.2 642.4 642.9 652.3 657.4 3347.5 3450.9 4091.3 4290.8 4316.5 80178.2 119153.0 122379.0 127612.0 128924.0 101453.0 105140.0 105639.5 109195.1 109411.5 93508.5 93973.0 94927.0 95403.5 97991.5 7848.3 7950.8 8181.4 8191.7 8469.0 36344.3 36507.6 39038.8 46614.8 48167.3 48051.5 49316.8 49960.0 64745.7 76947.2 13077.3 13086.3 13142.9 13200.5 13247.3 13909.7 14395.5 15350.0 15383.3 15679.5 13781.9 15026.7 15048.1 15067.9 15288.8 12627.7 13636.3 13652.5 13827.8 14637.7 12259.7 12936.0 12938.6 13018.8 14376.4 10988.6 11557.9 11939.6 12338.3 12352.3 12223.2 12386.9 12388.4 12432.5 12544.6 20:30:35 INFO - PROCESS | 22180 | -------- Summary: end -------- 20:30:35 INFO - PROCESS | 22180 | 20:30:35 INFO - TEST-INFO | 22180: exit 0 20:30:35 INFO - TEST-OK | dromaeo_css | took 1116838ms 20:30:35 INFO - TEST-START | kraken 20:30:35 INFO - operating with platform_type : linux_ 20:30:35 INFO - Initialising browser for kraken test... 20:30:35 INFO - TEST-INFO | started process 22492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2qJl2P/profile http://localhost:47952/getInfo.html) 20:30:40 INFO - PROCESS | 22492 | __metrics Screen width/height:1600/1200 20:30:40 INFO - PROCESS | 22492 | colorDepth:24 20:30:40 INFO - PROCESS | 22492 | Browser inner width/height: 1024/697 20:30:40 INFO - PROCESS | 22492 | __metrics 20:30:40 INFO - PROCESS | 22492 | 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" 20:30:40 INFO - PROCESS | 22492 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:30:41 INFO - PROCESS | 22492 | console.error: PushService: 20:30:41 INFO - PROCESS | 22492 | stateChangeProcessEnqueue: Error transitioning state 20:30:41 INFO - PROCESS | 22492 | UnknownError 20:30:42 INFO - TEST-INFO | 22492: exit 0 20:30:42 INFO - Browser initialized. 20:30:42 INFO - Running cycle 1/1 for kraken test... 20:30:42 INFO - TEST-INFO | started process 22575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2qJl2P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:30:54 INFO - PROCESS | 22575 | RSS: Main: 173789184 20:30:54 INFO - PROCESS | 22575 | 20:30:56 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47952/tests/kraken/driver.html?testName=audio-beat-detection) 20:30:57 INFO - PROCESS | 22575 | RSS: Main: 232919040 20:30:57 INFO - PROCESS | 22575 | 20:31:00 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47952/tests/kraken/driver.html?testName=audio-dft) 20:31:00 INFO - PROCESS | 22575 | RSS: Main: 217526272 20:31:00 INFO - PROCESS | 22575 | 20:31:04 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47952/tests/kraken/driver.html?testName=audio-fft) 20:31:04 INFO - PROCESS | 22575 | RSS: Main: 298762240 20:31:04 INFO - PROCESS | 22575 | 20:31:06 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47952/tests/kraken/driver.html?testName=audio-oscillator) 20:31:07 INFO - PROCESS | 22575 | RSS: Main: 208928768 20:31:07 INFO - PROCESS | 22575 | 20:31:09 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47952/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:31:10 INFO - PROCESS | 22575 | RSS: Main: 212803584 20:31:10 INFO - PROCESS | 22575 | 20:31:13 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47952/tests/kraken/driver.html?testName=imaging-darkroom) 20:31:13 INFO - PROCESS | 22575 | RSS: Main: 249274368 20:31:13 INFO - PROCESS | 22575 | 20:31:17 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47952/tests/kraken/driver.html?testName=imaging-desaturate) 20:31:17 INFO - PROCESS | 22575 | RSS: Main: 248545280 20:31:17 INFO - PROCESS | 22575 | 20:31:20 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47952/tests/kraken/driver.html?testName=json-parse-financial) 20:31:21 INFO - PROCESS | 22575 | RSS: Main: 248643584 20:31:21 INFO - PROCESS | 22575 | 20:31:22 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47952/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:31:23 INFO - PROCESS | 22575 | RSS: Main: 210956288 20:31:23 INFO - PROCESS | 22575 | 20:31:24 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47952/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:31:25 INFO - PROCESS | 22575 | RSS: Main: 217681920 20:31:25 INFO - PROCESS | 22575 | 20:31:27 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47952/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:31:28 INFO - PROCESS | 22575 | RSS: Main: 223686656 20:31:28 INFO - PROCESS | 22575 | 20:31:30 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:31:31 INFO - PROCESS | 22575 | RSS: Main: 223715328 20:31:31 INFO - PROCESS | 22575 | 20:31:34 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:31:34 INFO - PROCESS | 22575 | RSS: Main: 222257152 20:31:34 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:47952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47952/tests/kraken/driver.html?testName=ai-astar) 20:31:36 INFO - PROCESS | 22575 | RSS: Main: 273100800 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | __start_tp_report 20:31:36 INFO - PROCESS | 22575 | _x_x_mozilla_page_load 20:31:36 INFO - PROCESS | 22575 | _x_x_mozilla_page_load_details 20:31:36 INFO - PROCESS | 22575 | |i|pagename|runs| 20:31:36 INFO - PROCESS | 22575 | |0;ai-astar;109;110;110;111;111;111;111;110;110;110 20:31:36 INFO - PROCESS | 22575 | |1;audio-beat-detection;147;126;122;166;125;124;127;128;156;124 20:31:36 INFO - PROCESS | 22575 | |2;audio-dft;160;160;162;160;160;160;161;161;162;161 20:31:36 INFO - PROCESS | 22575 | |3;audio-fft;76;75;76;115;75;75;76;77;104;77 20:31:36 INFO - PROCESS | 22575 | |4;audio-oscillator;82;82;110;82;83;82;106;82;82;118 20:31:36 INFO - PROCESS | 22575 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;117;118;117 20:31:36 INFO - PROCESS | 22575 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;145;145 20:31:36 INFO - PROCESS | 22575 | |7;imaging-desaturate;96;95;95;95;95;95;94;95;95;95 20:31:36 INFO - PROCESS | 22575 | |8;json-parse-financial;50;51;52;50;52;52;51;52;52;51 20:31:36 INFO - PROCESS | 22575 | |9;json-stringify-tinderbox;60;60;61;61;61;61;62;62;61;61 20:31:36 INFO - PROCESS | 22575 | |10;stanford-crypto-aes;79;80;79;79;79;79;87;78;79;79 20:31:36 INFO - PROCESS | 22575 | |11;stanford-crypto-ccm;129;144;139;133;138;138;137;131;172;144 20:31:36 INFO - PROCESS | 22575 | |12;stanford-crypto-pbkdf2;166;171;165;166;168;175;165;168;162;164 20:31:36 INFO - PROCESS | 22575 | |13;stanford-crypto-sha256-iterative;66;66;65;65;64;66;64;65;68;63 20:31:36 INFO - PROCESS | 22575 | __end_tp_report 20:31:36 INFO - PROCESS | 22575 | __start_cc_report 20:31:36 INFO - PROCESS | 22575 | _x_x_mozilla_cycle_collect,1601 20:31:36 INFO - PROCESS | 22575 | __end_cc_report 20:31:36 INFO - PROCESS | 22575 | __startTimestamp1475551896815__endTimestamp 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | ------- Summary: start ------- 20:31:36 INFO - PROCESS | 22575 | Number of tests: 14 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 20:31:36 INFO - PROCESS | 22575 | Values: 109.0 110.0 110.0 111.0 111.0 111.0 111.0 110.0 110.0 110.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:127.50 stddev:15.81 (12.4%) stddev-sans-first:16.10 20:31:36 INFO - PROCESS | 22575 | Values: 147.0 126.0 122.0 166.0 125.0 124.0 127.0 128.0 156.0 124.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 20:31:36 INFO - PROCESS | 22575 | Values: 160.0 160.0 162.0 160.0 160.0 160.0 161.0 161.0 162.0 161.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:14.43 (19.0%) stddev-sans-first:15.11 20:31:36 INFO - PROCESS | 22575 | Values: 76.0 75.0 76.0 115.0 75.0 75.0 76.0 77.0 104.0 77.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.00 stddev:14.39 (17.6%) stddev-sans-first:14.90 20:31:36 INFO - PROCESS | 22575 | Values: 82.0 82.0 110.0 82.0 83.0 82.0 106.0 82.0 82.0 118.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 20:31:36 INFO - PROCESS | 22575 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:31:36 INFO - PROCESS | 22575 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 20:31:36 INFO - PROCESS | 22575 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.73 20:31:36 INFO - PROCESS | 22575 | Values: 50.0 51.0 52.0 50.0 52.0 52.0 51.0 52.0 52.0 51.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 20:31:36 INFO - PROCESS | 22575 | Values: 60.0 60.0 61.0 61.0 61.0 61.0 62.0 62.0 61.0 61.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:2.57 (3.3%) stddev-sans-first:2.71 20:31:36 INFO - PROCESS | 22575 | Values: 79.0 80.0 79.0 79.0 79.0 79.0 87.0 78.0 79.0 79.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:138.50 stddev:12.12 (8.8%) stddev-sans-first:12.12 20:31:36 INFO - PROCESS | 22575 | Values: 129.0 144.0 139.0 133.0 138.0 138.0 137.0 131.0 172.0 144.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.00 stddev:3.74 (2.2%) stddev-sans-first:3.95 20:31:36 INFO - PROCESS | 22575 | Values: 166.0 171.0 165.0 166.0 168.0 175.0 165.0 168.0 162.0 164.0 20:31:36 INFO - PROCESS | 22575 | 20:31:36 INFO - PROCESS | 22575 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.40 (2.1%) stddev-sans-first:1.45 20:31:36 INFO - PROCESS | 22575 | Values: 66.0 66.0 65.0 65.0 64.0 66.0 64.0 65.0 68.0 63.0 20:31:36 INFO - PROCESS | 22575 | -------- Summary: end -------- 20:31:36 INFO - PROCESS | 22575 | 20:31:38 INFO - TEST-INFO | 22575: exit 0 20:31:38 INFO - TEST-OK | kraken | took 62218ms 20:31:38 INFO - SUITE-END | took 1179s 20:31:38 INFO - Completed test suite (00:19:39) 20:31:38 INFO - javascript benchmark 20:31:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.2690990707274, 3010.3226773975857, 3014.2615059310474, 3040.817550946942, 3058.2201538607665, 5064.468230835764, 5152.278680984665, 5218.791248350061, 5219.92170117448, 5280.128778751511, 5112.514311140436, 5179.14544100223, 5195.714235717034, 5297.523222909937, 5329.094054010818, 4765.046990601876, 4780.737059461728, 4810.927836082462, 4866.999999999991, 4895.31465594817, 4759.911916220767, 4764.0, 4820.517948205169, 4850.102730994759, 4901.436334821506, 4798.664093513456, 4824.324594556747, 4833.468318484964, 4833.589144922686, 4897.583705385029, 4675.719456832601, 4724.173269677827, 4735.360726301974, 4800.495947925488, 4840.419149702023, 4770.045990801854, 4774.164521208774, 4782.23484242523, 4829.951700482985, 4857.781399837016, 5194.766235519411, 5198.16829307309, 5238.0, 5243.842684719426, 5251.396089449686, 5381.811636592701, 5448.727563621803, 5575.275214222125, 5576.052071147915, 5587.078132108198, 5638.40796716343, 5661.2357331760095, 5712.457316554921, 5718.456746609066, 5720.8855822883725, 5262.263283140325, 5266.973665131688, 5267.341582302212, 5269.235960785664, 5269.288646032736, 5541.639793413416, 5598.608097433141, 5777.104548794943, 5778.739956701958, 5842.970785146047, 5359.624826262124, 5398.64908780928, 5400.135978243541, 5401.02781499326, 5472.50747432733, 5430.728463576806, 5477.698726570077, 5482.890342193134, 5482.945170548323, 5485.204645326406, 5374.27447294618, 5421.185566753522, 5467.890642187134, 5479.424660410679, 5535.6955367454375, 5427.077396842467, 5540.0, 5562.860928476821, 5612.522935550524, 5679.403662615366, 4367.759773212504, 4375.628071613948, 4378.387025816388, 4408.53710360414, 4416.138852923649, 3878.7284890057426, 3888.0279930017496, 3898.0449789801114, 3939.862104826317, 3942.1130245695063, 5152.948470515247, 5350.117230656976, 5357.464253574689, 5359.544438722674, 5364.8122315718765, 5486.945130548724, 5492.340919089655, 5557.138643510262, 5570.41510641385, 5655.886882262332, 5234.26720259164, 5264.947350526446, 5283.603729720209, 5285.0, 5286.60350473716, 4866.270059491034, 4867.780949857194, 4877.853664390074, 4880.243562247857, 4880.341153944243, 5496.7526461309335, 5542.0, 5693.800716974886, 5745.396733342939, 5748.6838223898085, 5643.435656434488, 5644.971775141098, 5647.0, 5652.7738890443925, 5699.971500142473, 5749.798757043483, 5759.04975679025, 5765.221695071112, 5774.913376299275, 5777.335606405317, 5337.932413517235, 5367.194920761917, 5485.6982865942755, 5533.170024496358, 5539.501444869981, 5617.662940223599, 5657.8019769307875, 5660.320761508646, 5717.313922329347, 5739.9139012914, 5524.06090964529, 5531.115021596525, 5534.7509362078, 5534.833954981357, 5535.363433205233, 5350.357957045024, 5397.865053373697, 5415.566754659539, 5460.180972854104, 5584.497395234448, 5345.33183352081, 5405.324334458192, 5405.351357837085, 5454.481824226692, 5457.426970168075, 5473.261109750133, 5475.5072043516275, 5479.808206712746, 5484.61607687474, 5492.450754924475, 5202.843914682566, 5261.657992230493, 5263.131583288715, 5287.68273903567, 5333.040052790535], "value": 5158.032501271493, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.86371270895, 589.2251689028926, 601.7713268957796, 603.4960807725549, 626.8902941985153, 31347.84326078369, 32240.355192896128, 42041.369379459255, 42962.78518607403, 43050.35424468636, 41644.0, 46052.76973615127, 46154.0, 46176.53823461764, 46200.30699539501, 8854.0, 9000.954995225014, 9001.684941027066, 9010.954945225265, 9019.909800902005, 8075.5154690718455, 8296.460730052557, 8928.24109950655, 10588.3646981181, 10850.0, 11002.284851484668, 11055.0, 11074.612388566402, 11075.446227688582, 11077.833832492519, 10778.514966826511, 10831.620893268777, 10839.945800271027, 10840.67477975662, 10841.13270938323, 10482.737931551696, 10555.6749623869, 10557.472126393726, 10563.47182640865, 10564.78870422595, 42709.0, 43281.13437731259, 43289.78355108236, 43327.35008974868, 43361.56638433607, 3399.762016658835, 3413.8805141819917, 3488.3895318319446, 3510.7893526388243, 3672.9348488938444, 31475.213119671964, 31622.0, 31644.36711265785, 31920.680793192005, 33134.6686533134, 4213.536510983789, 4263.424437700933, 4298.26929421999, 4329.588689074533, 4375.16871794358, 341991.0, 343701.0, 344295.0, 344465.0, 344503.0, 56592.71703641456, 56721.43278567244, 56966.0, 57010.71494642583, 57053.42946570481, 36110.277794443966, 36689.81655091707, 36951.0, 38853.805730971166, 38901.0, 16243.269052892412, 16517.834821651628, 16525.173741312887, 16534.173291335625, 16537.503874883772, 10900.40047797363, 12101.394930253453, 12238.0, 12262.448189831479, 12283.14018018748, 16439.506814795575, 18455.354062607745, 18792.53018674544, 19148.425547233604, 19618.705719413934, 7046.330598593126, 7059.647017649199, 7210.978832674776, 7370.963145184347, 7451.254874512505, 916.2166347772692, 979.9657012004545, 1029.7374169586708, 1105.4362275239525, 1116.268843907242, 28852.0, 28891.422171556453, 28924.132276031753, 29037.274068148043, 29077.854610726812, 1058.0688993685508, 1059.6926891201465, 1104.0670633314837, 1115.3475216997986, 1135.8580177477816, 15130.319135638923, 15970.520884373487, 15996.600084997968, 16067.357305707874, 16240.0, 532281.0, 536534.0, 538164.0, 538383.0, 538504.0, 56237.718811405684, 56671.0, 56723.0, 56744.43255567474, 56813.0, 1198.4606926882936, 1214.1743614342156, 1299.175023859837, 1319.228251472899, 1345.3273363318538, 27860.30349241285, 29154.0, 29942.550861736654, 30343.84828075934, 30549.847250763603, 48328.0, 48703.756481218785, 48842.51157488522, 48889.266661000824, 48981.75509122432, 379549.0, 383294.0, 383413.0, 384740.83110025857, 385273.0, 25277.62083568711, 25693.486130277663, 25951.22146335613, 25985.350366240997, 27143.321416964733, 45087.29476231305, 45586.0, 45730.771346143054, 45923.540764593265, 46353.0, 38531.80734096312, 38629.4205586922, 39073.804630976665, 40479.79760101181, 40809.59190408058, 38372.424413633256, 38530.0, 39341.803290983364, 39564.0, 40727.79636101801, 34466.138346541535, 35192.0, 35300.117497062776, 35424.0, 38148.80925595354, 32911.835440822644, 34925.30149396947, 35201.0, 36096.0, 36097.917062488166, 25502.872485637454, 25953.740462595888, 25970.0, 26185.73814261833, 26241.343966400993], "value": 19534.239768112406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.9779213247207, 391.33473095737236, 391.5966554448918, 401.19360086226686, 419.76283399879065, 13347.399367028484, 18721.0, 19315.0, 20153.697694534556, 20295.59408811823, 18177.182026808794, 18992.810071899275, 19139.468842492603, 19173.137208825603, 19187.13657885395, 5597.160425936112, 5911.142884281777, 5914.852128696795, 5915.319738230094, 5921.0, 5666.291713535808, 5690.374058853523, 5742.0238559445, 5743.885122297552, 5764.452377024197, 5713.143028545731, 5713.74288157034, 5716.7141642917895, 5720.542356611482, 5723.656580605177, 5591.6365436246715, 5698.6865722385255, 5750.0, 5770.740316685738, 5777.45114214149, 5188.429272779991, 5197.480251974772, 5202.92195617066, 5203.0, 5203.4016088149965, 22825.201117960958, 22923.197688081003, 22955.08179672811, 23073.76926230733, 23111.88444057769, 2379.7858192762733, 2476.2199907029226, 2492.476579918219, 2585.6380106784877, 2873.3391319996517, 13923.651908702364, 14211.50259740904, 14263.714725705428, 14564.490242841555, 14944.925275373553, 1871.2514994002509, 1895.0, 1944.9027548622653, 1973.6250112478726, 1994.1524851937868, 54397.0, 80420.59789701072, 82438.58780706118, 83451.58274208651, 85025.0, 10229.539670714836, 10562.89437105619, 10712.303700259457, 11056.226064175431, 11604.76790464186, 14690.045147065406, 15188.316525756367, 15188.848111518964, 15204.847951520564, 15216.163111029, 8166.83666326682, 8169.591520423955, 8242.752717418487, 8334.249917507454, 8349.4155409122, 7738.651760670783, 7754.263344982218, 7872.291493765474, 7997.440179187517, 8025.23760242776, 6346.0, 6498.480121590262, 6521.673916304166, 6613.503987200883, 6727.29363416844, 1885.8397036252072, 1892.098441066719, 1919.1459800388973, 1931.430228082719, 1949.9122539485757, 867.9392442528963, 929.5073610986188, 970.4759429907912, 983.9163671087895, 1020.3775696824931, 17424.303027878745, 17920.283188672307, 18008.279668813364, 18054.3680971168, 18791.81208187928, 962.6005207838808, 964.0, 986.7730422002836, 996.531630133836, 1051.8685164354456, 10222.335548189492, 10671.786564268827, 10703.73240668974, 10723.356598604109, 10800.135989120852, 420434.62828632933, 424592.0, 424604.0, 439064.0, 442857.0, 79372.6031369851, 80265.0, 82819.5859020701, 83957.58021209855, 84103.5794821022, 995.193892946701, 1034.343192073039, 1063.803196408667, 1065.7974984752873, 1069.5935544493043, 15824.129672867643, 16283.837161628233, 16553.586160345607, 16687.165641718108, 16976.490705278862, 31837.6816231844, 37934.43098353582, 38214.617853822216, 39850.800745996086, 39946.800265998485, 51733.482665172865, 51869.7406512965, 52118.0, 52220.73889630527, 53487.8488973773, 7845.097813751491, 7975.202479752211, 7998.400119990907, 8157.143499932422, 8183.63173657175, 11158.274712143684, 12640.0, 12703.618891433272, 13012.349382531025, 13087.934560327138, 10482.63310784119, 10918.12654987615, 11133.109351251718, 11172.553097875994, 11625.0, 10512.316699414514, 10852.837207441737, 11041.39272339997, 11124.61063862761, 11239.719007024889, 10672.89327106719, 10833.0, 10906.745724241497, 11093.278936869077, 11269.211155219384, 8135.593220338841, 8347.332213422791, 8490.702825401082, 8525.019622743464, 8623.65505379803, 8859.867101993346, 10558.788824223318, 10636.468176590985, 10774.622888198875, 11413.0], "value": 9101.22801908036, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.2632978191778, 1465.1428914085259, 1518.5975716435146, 1627.9104649244293, 1792.0949920290243, 7903.881441778378, 8821.558922053895, 8988.865167022483, 9046.09539046096, 9332.813343733122, 9130.589123489442, 9173.724788256362, 9175.95412022939, 9178.036306187854, 9191.35660503765, 2302.6776251324786, 2346.483773569812, 2349.530093981202, 2354.682117914085, 2355.764423557639, 2209.3371988403496, 2214.202886960693, 2281.2927992322434, 2285.2915596165158, 2288.370698058039, 2274.920377786778, 2296.873671948042, 2298.0463107810237, 2325.8720770357622, 2330.860148391102, 2228.242397584821, 2244.0911430870524, 2255.041607316884, 2258.2660635293514, 2259.1302348595746, 2215.080741492279, 2233.542123864604, 2234.843560950734, 2253.605619016682, 2256.9548609027893, 9170.266378689756, 9212.861807072899, 9232.584533696, 9246.35275530713, 9255.398399104037, 5109.9489005109845, 5127.641065125443, 5262.973685131588, 5269.6311258211945, 5270.868228294285, 3378.712809411203, 3462.1517728156764, 3488.4069708149677, 3537.9292414151573, 3542.5394698689006, 1066.9946650266777, 1108.4457771114444, 1115.8549388579513, 1116.5087361560968, 1117.1398023521842, 12769.233845969178, 12816.615501534876, 12885.033622478351, 12937.0, 12953.546625868144, 4320.509424248629, 4419.204543182193, 4487.640988720895, 4545.681802273809, 4551.635869130461, 9968.700938971697, 9971.05274998874, 9979.301448898508, 9992.550335234931, 10004.0, 5136.357955255593, 5143.3570803649545, 5154.7164905929785, 5159.0, 5162.97418512905, 4266.445362102907, 4368.322909948963, 4728.621710263171, 4806.423229212517, 4880.487548807395, 3772.2078363543415, 3954.663853572421, 4003.7597744135446, 4052.1085361220485, 4064.4106604542176, 1196.581196581207, 1224.0819385460904, 1227.9877201227873, 1231.0643910627807, 1250.7498500299976, 854.4747625488598, 872.3108744092096, 889.177510802518, 900.5182227508252, 925.0980294213089, 5649.774009039675, 5660.471672648444, 5687.146927960839, 5691.8292451226525, 5769.394213607511, 932.8181004704018, 945.2768631996528, 964.4165280005636, 984.9950750246346, 1030.9020892749197, 3696.8706095286534, 3760.041189496661, 3776.8866933992026, 3782.7541209821275, 3906.43356713275, 10962.835557466644, 11365.886341136484, 11373.090152787758, 11385.601503947488, 11433.771324573461, 11263.211575189822, 11265.718357040976, 11270.380129092815, 11274.323540587427, 11277.32336059839, 7843.764687059397, 8138.348932085537, 8349.66601335952, 8509.361797865186, 8522.275606573387, 5535.335759708861, 5562.415946325577, 5595.832125036255, 5650.152477128464, 5732.684702341411, 9604.95197524008, 9848.310618256653, 10245.948770256102, 10368.326058806153, 10487.580496780043, 10496.107830834464, 10578.8413173804, 10682.305650132717, 10687.732806679895, 10837.891621083689, 7304.7078116876855, 7473.551586904803, 7539.9246007541415, 7544.735934242275, 7618.276263754934, 7888.960555197187, 8641.956790216009, 8663.696770612998, 8953.059928707393, 8985.236254918405, 7378.557286562609, 7489.28851759082, 7595.202503737028, 7741.264579864904, 7741.92258077412, 7325.706971721072, 7621.390288776774, 7660.425468089804, 7679.808004799701, 7884.369250459835, 6513.185851768529, 6608.4052435281055, 6610.3720146586, 6616.073749674953, 6622.933770662425, 4819.831305904277, 4869.537393947569, 4933.333999909966, 4936.802527898843, 4963.950360496348, 5006.599472042155, 5065.924011139762, 5093.490650934877, 5175.9741201293755, 5186.481351864934], "value": 4594.846066989818, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.20626013218606, 344.6949449736982, 345.1113383038676, 351.97888126712417, 352.8641473032882, 5329.294625719771, 5341.759620817063, 5352.143657014878, 5357.732113394324, 5388.649737767042, 5211.661242019276, 5215.139501982168, 5227.372715274172, 5328.227407025979, 5336.893262134765, 3929.607039296069, 4052.1490486997764, 4061.1065565575527, 4141.337386018237, 4175.248455278064, 4160.271952408331, 4160.667146628278, 4170.582941705836, 4171.80979985507, 4188.602082802129, 4123.9381409278885, 4130.834766609347, 4152.231837110145, 4154.0, 4154.729942553739, 3931.724779265467, 3944.1322908959983, 4105.651019663333, 4105.932457561025, 4171.520275168334, 3652.3608368535665, 3652.6850333879784, 3674.540682414698, 3680.3743363628246, 3691.187938653519, 5076.898462030738, 5095.847124586268, 5097.617678674114, 5141.640085194038, 5178.533931946143, 4425.513193548707, 4606.170889239936, 4686.484486706459, 4687.10944920464, 4727.456342520585, 5409.215663728737, 5434.206711785101, 5438.320209973754, 5443.475826768472, 5445.727713614304, 3922.431027588959, 3933.1543718100747, 3936.940945885814, 3945.3687410014545, 3962.0689138052535, 5546.362168350651, 5637.323521177444, 5640.774369025234, 5642.12547055203, 5756.913646295309, 4023.376376661622, 4034.5561988181275, 4040.9595904040584, 4055.8986025349604, 4056.878293651136, 4098.4876890388705, 4107.342825147962, 4118.897027574275, 4135.17296540687, 4137.958620413818, 4597.3333866589155, 4640.2024670691635, 4662.230731929261, 4714.787834547454, 4722.52774722525, 5475.644083134664, 5486.558481475705, 5515.806946756844, 5524.696141712245, 5542.39033706292, 1413.2156653057652, 1431.4918204037417, 1433.3979728514048, 1434.3330351386655, 1435.3253970633784, 856.6402111113347, 910.886139232596, 924.3714274293545, 941.773974246176, 943.7499062748377, 5151.0, 5170.870728231825, 5355.196720491879, 5363.973180134074, 5372.973135134299, 5637.379888212294, 5706.3722990471015, 5708.257926469615, 5726.656400615976, 5752.856178595485, 5082.364704411949, 5372.140457526777, 5387.568994480433, 5408.378036525771, 5408.486193811582, 2980.6125203723377, 3017.8641961111803, 3025.2285667154733, 3029.4546981543094, 3030.7876849260474, 5875.236219291465, 5881.647101173858, 5883.941160588425, 5892.5285977122585, 5899.292084949833, 5637.520810731134, 5798.159266906359, 5808.332041815161, 5811.4479124483105, 5825.854353641193, 5823.708814559255, 5857.355690874, 5861.38811826751, 5867.442592953663, 5879.265091863517, 5393.487618676219, 5637.5489960802215, 5648.435156484319, 5666.744996475251, 5711.314642242957, 5586.664800112007, 5591.8881622368135, 5593.440655934537, 5603.943960560342, 5614.242077319673, 5781.785824976802, 5794.0, 5820.359760426434, 5821.864736376366, 5834.854128646818, 3922.2939870823525, 4036.172584620087, 4045.37296719009, 4077.8776636700945, 4085.652719518874, 5603.859903502445, 5605.906848164569, 5623.493885550321, 5626.943730562642, 5640.915386269127, 5555.916661250165, 5574.944250557604, 5580.832575022756, 5585.045234168008, 5594.944050559605, 5312.5218730314455, 5496.444153468657, 5521.4478552144465, 5524.33707955048, 5526.171074338881, 5461.756713555032, 5463.153211252262, 5464.644798088111, 5488.530161427294, 5528.502434780889, 5319.973400132974, 5359.383670877899, 5476.616636835383, 5558.749856256559, 5576.275084239023, 5439.292891924025, 5448.509634132947, 5453.282216101915, 5469.097598896296, 5469.453054694499], "value": 4220.808828367047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.334598861025, 742.5730205132049, 774.4733581164809, 781.8827175923607, 799.9000124984377, 14471.421143154274, 15268.541943741679, 15339.769903451457, 15362.54342772877, 15369.846301536982, 15392.384304627829, 15491.225438728075, 15519.767203491929, 15521.301541430634, 15552.68894622107, 648.9870202595945, 651.4397618048474, 759.0, 760.467672629159, 763.8090477380655, 765.4947734495234, 769.86142494351, 769.8768197088467, 770.4029377232662, 775.5385545600359, 807.5316316536424, 809.9433039687224, 810.7770363150122, 811.059171361221, 811.1969150540981, 664.1565212180528, 678.1556961582861, 680.5542369747823, 682.9931700682979, 805.017878188609, 574.8591595059196, 584.9181114643953, 585.5081731345648, 589.8525368657836, 592.9407059294036, 14181.716365672628, 14216.786748198785, 14223.146611203361, 14226.217558034305, 14236.928815355961, 13431.0, 13559.25424101674, 13740.312984350743, 14262.500812471513, 14595.78106328406, 12231.449584768707, 12304.384780760925, 12405.565805196866, 12636.0, 12687.619371418872, 4340.8697739067875, 4362.650987920959, 4454.665900057476, 4519.909601807945, 4532.954670453286, 75481.62259188724, 76114.61942690307, 76827.0, 76990.0, 78193.60903195504, 11056.502457389437, 11104.888951110546, 11373.31760094397, 11377.203595748384, 11444.427778611036, 21192.894035530033, 21204.25785097514, 21345.35963921085, 21378.78621213799, 21420.678689819666, 8065.798355041054, 8127.0, 8138.633761480747, 8219.342452603778, 8275.379346549033, 4253.787310634518, 4428.800703968329, 4455.844045458458, 4526.388937493396, 4594.5864872161665, 3529.7176225901867, 3672.045268230226, 3672.3940549809518, 3675.4854320395166, 3676.485292059114, 631.9083732858802, 636.0903907412352, 638.3170008091298, 642.1491523731075, 648.2545073165898, 599.7481057955582, 654.7577396363376, 657.2901266632026, 669.3172963577124, 685.116200101873, 8014.559199243981, 9191.494467804336, 9269.768255793524, 9336.346455748168, 9545.618175272912, 641.2049059166693, 642.4442856928723, 642.8553575445487, 652.2759736692268, 657.4280376072752, 3347.4811404232382, 3450.879219227315, 4091.3453847384276, 4290.806913688892, 4316.5467625899455, 80178.19821801824, 119153.0, 122379.0, 127612.0, 128924.0, 101453.0, 105140.0, 105639.47180264049, 109195.0747634118, 109411.45294273637, 93508.53245733863, 93973.0, 94927.0, 95403.52298238465, 97991.51004244933, 7848.293653570978, 7950.801229969297, 8181.427300088937, 8191.713290034821, 8468.957655211685, 36344.27311453809, 36507.634923650425, 39038.804805975786, 46614.76692616515, 48167.277490838365, 48051.5194848061, 49316.75341623269, 49960.0, 64745.676271618344, 76947.230527694, 13077.260667478075, 13086.280254586089, 13142.868571314164, 13200.471981120647, 13247.337633118499, 13909.721805564035, 14395.496157634432, 15350.0, 15383.30775115145, 15679.451219207273, 13781.931090344484, 15026.6994660104, 15048.097114172746, 15067.924660376628, 15288.847111529187, 12627.74744505123, 13636.250006249355, 13652.522161724291, 13827.792583111463, 14637.707245855236, 12259.693507662023, 12936.0, 12938.611841644766, 13018.80471792905, 14376.353064112349, 10988.615398461016, 11557.942210288895, 11939.582114625946, 12338.259704417764, 12352.320622365856, 12223.205491643015, 12386.938065309616, 12388.380580971096, 12432.502699892264, 12544.560940367044], "value": 7343.926479089081, "unit": "score"}], "name": "dromaeo_css", "value": 7123.116867406193, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 122.0, 166.0, 125.0, 124.0, 127.0, 128.0, 156.0, 124.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 115.0, 75.0, 75.0, 76.0, 77.0, 104.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 82.0, 83.0, 82.0, 106.0, 82.0, 82.0, 118.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 50.0, 52.0, 52.0, 51.0, 52.0, 52.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 79.0, 79.0, 87.0, 78.0, 79.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 144.0, 139.0, 133.0, 138.0, 138.0, 137.0, 131.0, 172.0, 144.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 165.0, 166.0, 168.0, 175.0, 165.0, 168.0, 162.0, 164.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 64.0, 66.0, 64.0, 65.0, 68.0, 63.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1501.3, "alertThreshold": 2.0}]} 20:31:38 INFO - Return code: 0 20:31:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:31:38 INFO - # TBPL SUCCESS # 20:31:38 INFO - Running post-action listener: _resource_record_post_action 20:31:38 INFO - [mozharness: 2016-10-04 03:31:38.602261Z] Finished run-tests step (success) 20:31:38 INFO - Running post-run listener: _resource_record_post_run 20:31:38 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392908800; Read time: 12; Write time: 255768 20:31:38 INFO - TinderboxPrint: CPU usage
13.0% 20:31:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:31:38 INFO - TinderboxPrint: I/O write bytes / time
392,908,800 / 255,768 20:31:38 INFO - TinderboxPrint: CPU idle
8,308.9 (87.0%) 20:31:38 INFO - TinderboxPrint: CPU user
1,190.7 (12.5%) 20:31:38 INFO - TinderboxPrint: Swap in / out
0 / 0 20:31:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103591936; Read time: 0; Write time: 60888 20:31:38 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288112640; Read time: 0; Write time: 194192 20:31:39 INFO - Running post-run listener: _upload_blobber_files 20:31:39 INFO - Blob upload gear active. 20:31:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:31:39 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 20:31:39 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'] 20:31:39 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 20:31:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:31:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:31:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:31:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:40 INFO - (blobuploader) - INFO - Done attempting. 20:31:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:31:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:31:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:41 INFO - (blobuploader) - INFO - Done attempting. 20:31:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:31:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:45 INFO - (blobuploader) - INFO - Done attempting. 20:31:45 INFO - (blobuploader) - INFO - Iteration through files over. 20:31:45 INFO - Return code: 0 20:31:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:31:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:31:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b7d8ee814245cef7007d127a2c8b0f0045071a175ec15433104cfc97bcd4fc92741417b5aca61818d1a9157c5ce8385a83df1c80ff0b2ec96540418879880e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7154c30749a5563291a3d04b23a53f8ebec0c7d12c8a6798a6bc0bf113b135b520715dbfc64510ef0f25bdb01d0ea9ab55d4885fd8701ca7003a821eba1dc315", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a77101bc171e5abc119b2cec5528acb117d23de2bffe1eee71e4be3b0954386aa184d849d59cd900ad1628ecc6f33ea0fe25ebc3a6428a6f1babca45b01ee958"} 20:31:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:31:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:31:45 INFO - Contents: 20:31:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b7d8ee814245cef7007d127a2c8b0f0045071a175ec15433104cfc97bcd4fc92741417b5aca61818d1a9157c5ce8385a83df1c80ff0b2ec96540418879880e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7154c30749a5563291a3d04b23a53f8ebec0c7d12c8a6798a6bc0bf113b135b520715dbfc64510ef0f25bdb01d0ea9ab55d4885fd8701ca7003a821eba1dc315", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a77101bc171e5abc119b2cec5528acb117d23de2bffe1eee71e4be3b0954386aa184d849d59cd900ad1628ecc6f33ea0fe25ebc3a6428a6f1babca45b01ee958"} 20:31:45 INFO - Running post-run listener: copy_logs_to_upload_dir 20:31:45 INFO - Copying logs to upload dir... 20:31:45 INFO - mkdir: /builds/slave/test/build/upload/logs 20:31:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.326088 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-03 20:31:45.154269) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 20:31:45.158548) ========= 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=7de08804244eb36560b44971000001c3-1475549891.499186-2097100403 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/2b7d8ee814245cef7007d127a2c8b0f0045071a175ec15433104cfc97bcd4fc92741417b5aca61818d1a9157c5ce8385a83df1c80ff0b2ec96540418879880e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7154c30749a5563291a3d04b23a53f8ebec0c7d12c8a6798a6bc0bf113b135b520715dbfc64510ef0f25bdb01d0ea9ab55d4885fd8701ca7003a821eba1dc315", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a77101bc171e5abc119b2cec5528acb117d23de2bffe1eee71e4be3b0954386aa184d849d59cd900ad1628ecc6f33ea0fe25ebc3a6428a6f1babca45b01ee958"} build_url:https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/KY3qEi2BSumSqFfzdFWU-A/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/2b7d8ee814245cef7007d127a2c8b0f0045071a175ec15433104cfc97bcd4fc92741417b5aca61818d1a9157c5ce8385a83df1c80ff0b2ec96540418879880e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7154c30749a5563291a3d04b23a53f8ebec0c7d12c8a6798a6bc0bf113b135b520715dbfc64510ef0f25bdb01d0ea9ab55d4885fd8701ca7003a821eba1dc315", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a77101bc171e5abc119b2cec5528acb117d23de2bffe1eee71e4be3b0954386aa184d849d59cd900ad1628ecc6f33ea0fe25ebc3a6428a6f1babca45b01ee958"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 20:31:45.189542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:31:45.189871) ========= 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=7de08804244eb36560b44971000001c3-1475549891.499186-2097100403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 20:31:45.268892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 20:31:45.272253) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 20:31:45.272620) ========= ========= Total master_lag: 0.20 =========