builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1479390537.12 results: success (0) buildid: 20161117030212 builduid: c298b52a4b464d9ea352f6c8ae53d8d8 revision: 13f49da109ea460665ad27c8497cb1489548450c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:57.124519) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:57.125093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:57.125426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:57.161175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:57.161871) ========= 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=6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 05:48:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-11-17 05:48:57 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165169 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:57.359050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:57.359760) ========= 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=6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017604 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:57.412137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:57.412503) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13f49da109ea460665ad27c8497cb1489548450c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 13f49da109ea460665ad27c8497cb1489548450c --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=6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 05:48:57,585 truncating revision to first 12 chars 2016-11-17 05:48:57,585 Setting DEBUG logging. 2016-11-17 05:48:57,585 attempt 1/10 2016-11-17 05:48:57,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13f49da109ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 05:48:58,008 unpacking tar archive at: mozilla-central-13f49da109ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.778841 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:58.209381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:58.210231) ========= script_repo_revision: 13f49da109ea460665ad27c8497cb1489548450c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:58.211238) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:58.211988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 05:48:58.229406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-17 05:48:58.229720) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:48:58 INFO - MultiFileLogger online at 20161117 05:48:58 in /builds/slave/test 05:48:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:48:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:58 INFO - {'append_to_log': False, 05:48:58 INFO - 'base_work_dir': '/builds/slave/test', 05:48:58 INFO - 'blob_upload_branch': 'Firefox', 05:48:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:58 INFO - 'branch': 'Firefox', 05:48:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:58 INFO - 'config_files': ('talos/linux_config.py',), 05:48:58 INFO - 'default_actions': ('clobber', 05:48:58 INFO - 'read-buildbot-config', 05:48:58 INFO - 'download-and-extract', 05:48:58 INFO - 'populate-webroot', 05:48:58 INFO - 'create-virtualenv', 05:48:58 INFO - 'install', 05:48:58 INFO - 'run-tests'), 05:48:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:58 INFO - 'download_minidump_stackwalk': True, 05:48:58 INFO - 'download_symbols': 'ondemand', 05:48:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:58 INFO - 'installer_path': 'installer.exe', 05:48:58 INFO - 'log_level': 'info', 05:48:58 INFO - 'log_name': 'talos', 05:48:58 INFO - 'log_to_console': True, 05:48:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:48:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:48:58 INFO - 'opt_config_files': (), 05:48:58 INFO - 'pip_index': False, 05:48:58 INFO - 'sps_profile': False, 05:48:58 INFO - 'sps_profile_interval': 0, 05:48:58 INFO - 'suite': 'dromaeojs', 05:48:58 INFO - 'system_bits': '32', 05:48:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:58 INFO - 'title': 'talos-linux64-ix-023', 05:48:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:58 INFO - 'use_talos_json': True, 05:48:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:58 INFO - 'work_dir': 'build'} 05:48:58 INFO - [mozharness: 2016-11-17 13:48:58.582525Z] Running clobber step. 05:48:58 INFO - Running pre-action listener: _resource_record_pre_action 05:48:58 INFO - Running main action method: clobber 05:48:58 INFO - rmtree: /builds/slave/test/build 05:48:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:58 INFO - Running post-action listener: _resource_record_post_action 05:48:58 INFO - [mozharness: 2016-11-17 13:48:58.993340Z] Finished clobber step (success) 05:48:58 INFO - [mozharness: 2016-11-17 13:48:58.993440Z] Running read-buildbot-config step. 05:48:58 INFO - Running pre-action listener: _resource_record_pre_action 05:48:58 INFO - Running main action method: read_buildbot_config 05:48:58 INFO - Using buildbot properties: 05:48:58 INFO - { 05:48:58 INFO - "project": "", 05:48:58 INFO - "product": "firefox", 05:48:58 INFO - "script_repo_revision": "production", 05:48:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:48:58 INFO - "repository": "", 05:48:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:48:58 INFO - "buildid": "20161117030212", 05:48:58 INFO - "stage_platform": "linux64-pgo", 05:48:58 INFO - "basedir": "/builds/slave/test", 05:48:58 INFO - "nightly_build": "True", 05:48:58 INFO - "buildnumber": 72, 05:48:58 INFO - "slavename": "talos-linux64-ix-023", 05:48:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:48:58 INFO - "platform": "ubuntu64_hw", 05:48:58 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:48:58 INFO - "branch": "mozilla-central", 05:48:58 INFO - "repo_path": "mozilla-central", 05:48:58 INFO - "revision": "13f49da109ea460665ad27c8497cb1489548450c", 05:48:58 INFO - "pgo_build": "True", 05:48:58 INFO - "builduid": "c298b52a4b464d9ea352f6c8ae53d8d8", 05:48:58 INFO - "slavebuilddir": "test" 05:48:58 INFO - } 05:48:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 05:48:58 INFO - Running post-action listener: _resource_record_post_action 05:48:58 INFO - [mozharness: 2016-11-17 13:48:58.995915Z] Finished read-buildbot-config step (success) 05:48:58 INFO - [mozharness: 2016-11-17 13:48:58.996002Z] Running download-and-extract step. 05:48:58 INFO - Running pre-action listener: _resource_record_pre_action 05:48:58 INFO - Running main action method: download_and_extract 05:48:58 INFO - mkdir: /builds/slave/test/build/tests 05:48: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')]} 05:48:58 INFO - trying https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:48:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:48:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:48:59 INFO - Downloaded 1361 bytes. 05:48:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:48:59 INFO - Using the following test package requirements: 05:48:59 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:59 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:48:59 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:48:59 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:59 INFO - u'jsshell-linux-x86_64.zip'], 05:48:59 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:48:59 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:59 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:48:59 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:48:59 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:48:59 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:48:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:48:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:48:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:48:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:49:00 INFO - Http code: 200 05:49:00 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 05:49:00 INFO - x-amz-cf-id: bSKJMgB45gXkcK2IZOBhRninQFp10cgq5ELAdxK4pAx0nsQsZj4jdw== 05:49:00 INFO - x-amz-version-id: ItC8Po_3OjfI9NRje2fF6xJTkMOmeRQg 05:49:01 INFO - Expected file size: 21914454 05:49:01 INFO - Obtained file size: 21914454 05:49:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:49:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:49:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:49:05 INFO - Http code: 200 05:49:05 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 05:49:05 INFO - x-amz-cf-id: Z2mtzZkbKeOwb57Mj9VRwoHI6afiJbNAe7cTrvei9oblbMJzcIWjcQ== 05:49:05 INFO - x-amz-version-id: ItC8Po_3OjfI9NRje2fF6xJTkMOmeRQg 05:49:05 INFO - Expected file size: 21914454 05:49:05 INFO - Obtained file size: 21914454 05:49:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:49:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:49:11 INFO - Http code: 200 05:49:11 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 05:49:11 INFO - x-amz-cf-id: e8W-iXXNxIvL_Vv2m2T4613oFPeyUq1HjH_kx4ELj_0b18pJuVeklg== 05:49:11 INFO - x-amz-version-id: w3jprV2NC9eSFJmMesSK4XlFESsI0v4K 05:49:11 INFO - Expected file size: 14409389 05:49:11 INFO - Obtained file size: 14409389 05:49:12 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')]} 05:49:12 INFO - trying https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:49:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:49:16 INFO - Downloaded 59539925 bytes. 05:49:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:49:16 INFO - mkdir: /builds/slave/test/properties 05:49:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:16 INFO - Contents: 05:49:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:49:16 INFO - Running post-action listener: _resource_record_post_action 05:49:16 INFO - Running post-action listener: set_extra_try_arguments 05:49:16 INFO - [mozharness: 2016-11-17 13:49:16.992791Z] Finished download-and-extract step (success) 05:49:16 INFO - [mozharness: 2016-11-17 13:49:16.993022Z] Running populate-webroot step. 05:49:16 INFO - Running pre-action listener: _resource_record_pre_action 05:49:16 INFO - Running main action method: populate_webroot 05:49:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:17 INFO - '--tppagecycles', 05:49:17 INFO - '7'], 05:49:17 INFO - 'tests': ['tsvgm']}}, 05:49:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:49:17 INFO - 'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:49:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:49:17 INFO - 'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['damp', 'tps']}, 05:49:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:49:17 INFO - 'tests': ['damp', 'tps']}, 05:49:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['dromaeo_dom']}, 05:49:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['basic_compositor_video']}, 05:49:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:49:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['tsvgx', 05:49:17 INFO - 'tsvgr_opacity', 05:49:17 INFO - 'tart', 05:49:17 INFO - 'tscrollx', 05:49:17 INFO - 'cart']}, 05:49:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:17 INFO - 'tsvgr_opacity', 05:49:17 INFO - 'tart', 05:49:17 INFO - 'tscrollx', 05:49:17 INFO - 'cart']}, 05:49:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:49:17 INFO - 'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['tp5o']}, 05:49:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:49:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:49:17 INFO - 'talos_options': ['--disable-e10s', 05:49:17 INFO - '--xperf_path', 05:49:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:17 INFO - 'tests': ['tp5n']}, 05:49:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:49:17 INFO - 'talos_options': ['--xperf_path', 05:49:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:17 INFO - 'tests': ['tp5n']}}, 05:49:17 INFO - 'talos.zip': {'path': '', 05:49:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:17 INFO - Running post-action listener: _resource_record_post_action 05:49:17 INFO - [mozharness: 2016-11-17 13:49:17.010753Z] Finished populate-webroot step (success) 05:49:17 INFO - [mozharness: 2016-11-17 13:49:17.010841Z] Running create-virtualenv step. 05:49:17 INFO - Running pre-action listener: _resource_record_pre_action 05:49:17 INFO - Running main action method: create_virtualenv 05:49:17 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:49:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:17 INFO - Using real prefix '/usr' 05:49:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:19 INFO - Installing pip.................done. 05:49:19 INFO - Return code: 0 05:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:49:20 INFO - Reading from file tmpfile_stdout 05:49:20 INFO - Output received: 05:49:20 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) 05:49:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:20 INFO - Using env: {'DISPLAY': ':0', 05:49:20 INFO - 'HOME': '/home/cltbld', 05:49:20 INFO - 'LANG': 'en_US.UTF-8', 05:49:20 INFO - 'LANGUAGE': 'en_US:en', 05:49:20 INFO - 'LOGNAME': 'cltbld', 05:49:20 INFO - 'MAIL': '/var/mail/cltbld', 05:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:20 INFO - 'MOZ_NO_REMOTE': '1', 05:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:20 INFO - 'NO_EM_RESTART': '1', 05:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:20 INFO - 'PWD': '/builds/slave/test', 05:49:20 INFO - 'SHELL': '/bin/bash', 05:49:20 INFO - 'SHLVL': '1', 05:49:20 INFO - 'TERM': 'linux', 05:49:20 INFO - 'TMOUT': '86400', 05:49:20 INFO - 'USER': 'cltbld', 05:49:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:20 INFO - '_': '/tools/buildbot/bin/python'} 05:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:49:20 INFO - Cleaning up... 05:49:20 INFO - Return code: 0 05:49:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:49:20 INFO - Using env: {'DISPLAY': ':0', 05:49:20 INFO - 'HOME': '/home/cltbld', 05:49:20 INFO - 'LANG': 'en_US.UTF-8', 05:49:20 INFO - 'LANGUAGE': 'en_US:en', 05:49:20 INFO - 'LOGNAME': 'cltbld', 05:49:20 INFO - 'MAIL': '/var/mail/cltbld', 05:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:20 INFO - 'MOZ_NO_REMOTE': '1', 05:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:20 INFO - 'NO_EM_RESTART': '1', 05:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:20 INFO - 'PWD': '/builds/slave/test', 05:49:20 INFO - 'SHELL': '/bin/bash', 05:49:20 INFO - 'SHLVL': '1', 05:49:20 INFO - 'TERM': 'linux', 05:49:20 INFO - 'TMOUT': '86400', 05:49:20 INFO - 'USER': 'cltbld', 05:49:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:20 INFO - '_': '/tools/buildbot/bin/python'} 05:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:20 INFO - Downloading/unpacking psutil>=3.1.1 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:22 INFO - Installing collected packages: psutil 05:49:22 INFO - Running setup.py install for psutil 05:49:22 INFO - building 'psutil._psutil_linux' extension 05:49:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:49:24 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 05:49:24 INFO - building 'psutil._psutil_posix' extension 05:49:24 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 05:49:24 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 05:49:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:24 INFO - Successfully installed psutil 05:49:24 INFO - Cleaning up... 05:49:24 INFO - Return code: 0 05:49:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:49: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 mozsystemmonitor==0.3 05:49:24 INFO - Using env: {'DISPLAY': ':0', 05:49:24 INFO - 'HOME': '/home/cltbld', 05:49:24 INFO - 'LANG': 'en_US.UTF-8', 05:49:24 INFO - 'LANGUAGE': 'en_US:en', 05:49:24 INFO - 'LOGNAME': 'cltbld', 05:49:24 INFO - 'MAIL': '/var/mail/cltbld', 05:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:24 INFO - 'MOZ_NO_REMOTE': '1', 05:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:24 INFO - 'NO_EM_RESTART': '1', 05:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:24 INFO - 'PWD': '/builds/slave/test', 05:49:24 INFO - 'SHELL': '/bin/bash', 05:49:24 INFO - 'SHLVL': '1', 05:49:24 INFO - 'TERM': 'linux', 05:49:24 INFO - 'TMOUT': '86400', 05:49:24 INFO - 'USER': 'cltbld', 05:49:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:24 INFO - '_': '/tools/buildbot/bin/python'} 05:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:27 INFO - Installing collected packages: mozsystemmonitor 05:49:27 INFO - Running setup.py install for mozsystemmonitor 05:49:27 INFO - Successfully installed mozsystemmonitor 05:49:27 INFO - Cleaning up... 05:49:27 INFO - Return code: 0 05:49:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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', '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 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:49: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 jsonschema==2.5.1 05:49:27 INFO - Using env: {'DISPLAY': ':0', 05:49:27 INFO - 'HOME': '/home/cltbld', 05:49:27 INFO - 'LANG': 'en_US.UTF-8', 05:49:27 INFO - 'LANGUAGE': 'en_US:en', 05:49:27 INFO - 'LOGNAME': 'cltbld', 05:49:27 INFO - 'MAIL': '/var/mail/cltbld', 05:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:27 INFO - 'MOZ_NO_REMOTE': '1', 05:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:27 INFO - 'NO_EM_RESTART': '1', 05:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:27 INFO - 'PWD': '/builds/slave/test', 05:49:27 INFO - 'SHELL': '/bin/bash', 05:49:27 INFO - 'SHLVL': '1', 05:49:27 INFO - 'TERM': 'linux', 05:49:27 INFO - 'TMOUT': '86400', 05:49:27 INFO - 'USER': 'cltbld', 05:49:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:27 INFO - '_': '/tools/buildbot/bin/python'} 05:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:27 INFO - Downloading/unpacking jsonschema==2.5.1 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:29 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:29 INFO - warning: no files found matching '*.txt' 05:49:29 INFO - no previously-included directories found matching 'build' 05:49:29 INFO - no previously-included directories found matching 'dist' 05:49:29 INFO - no previously-included directories found matching '.git*' 05:49:29 INFO - Installing collected packages: jsonschema, functools32 05:49:29 INFO - Running setup.py install for functools32 05:49:29 INFO - warning: no files found matching '*.txt' 05:49:29 INFO - no previously-included directories found matching 'build' 05:49:29 INFO - no previously-included directories found matching 'dist' 05:49:29 INFO - no previously-included directories found matching '.git*' 05:49:29 INFO - Successfully installed jsonschema functools32 05:49:29 INFO - Cleaning up... 05:49:30 INFO - Return code: 0 05:49:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:30 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 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49:30 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 05:49:30 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 05:49:30 INFO - Using env: {'DISPLAY': ':0', 05:49:30 INFO - 'HOME': '/home/cltbld', 05:49:30 INFO - 'LANG': 'en_US.UTF-8', 05:49:30 INFO - 'LANGUAGE': 'en_US:en', 05:49:30 INFO - 'LOGNAME': 'cltbld', 05:49:30 INFO - 'MAIL': '/var/mail/cltbld', 05:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:30 INFO - 'MOZ_NO_REMOTE': '1', 05:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:30 INFO - 'NO_EM_RESTART': '1', 05:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:30 INFO - 'PWD': '/builds/slave/test', 05:49:30 INFO - 'SHELL': '/bin/bash', 05:49:30 INFO - 'SHLVL': '1', 05:49:30 INFO - 'TERM': 'linux', 05:49:30 INFO - 'TMOUT': '86400', 05:49:30 INFO - 'USER': 'cltbld', 05:49:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:30 INFO - '_': '/tools/buildbot/bin/python'} 05:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:49:30 INFO - Cleaning up... 05:49:30 INFO - Return code: 0 05:49:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:30 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 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49:30 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 05:49:30 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 05:49:30 INFO - Using env: {'DISPLAY': ':0', 05:49:30 INFO - 'HOME': '/home/cltbld', 05:49:30 INFO - 'LANG': 'en_US.UTF-8', 05:49:30 INFO - 'LANGUAGE': 'en_US:en', 05:49:30 INFO - 'LOGNAME': 'cltbld', 05:49:30 INFO - 'MAIL': '/var/mail/cltbld', 05:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:30 INFO - 'MOZ_NO_REMOTE': '1', 05:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:30 INFO - 'NO_EM_RESTART': '1', 05:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:30 INFO - 'PWD': '/builds/slave/test', 05:49:30 INFO - 'SHELL': '/bin/bash', 05:49:30 INFO - 'SHLVL': '1', 05:49:30 INFO - 'TERM': 'linux', 05:49:30 INFO - 'TMOUT': '86400', 05:49:30 INFO - 'USER': 'cltbld', 05:49:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:30 INFO - '_': '/tools/buildbot/bin/python'} 05:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:30 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:33 INFO - Downloading docopt-0.6.1.tar.gz 05:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:33 INFO - Running setup.py install for blobuploader 05:49:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:33 INFO - Running setup.py install for requests 05:49:33 INFO - Running setup.py install for docopt 05:49:33 INFO - Successfully installed blobuploader requests docopt 05:49:33 INFO - Cleaning up... 05:49:33 INFO - Return code: 0 05:49:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:33 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')]} 05:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:33 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')]} 05:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:33 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 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49:33 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 05:49:33 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 05:49:33 INFO - Using env: {'DISPLAY': ':0', 05:49:33 INFO - 'HOME': '/home/cltbld', 05:49:33 INFO - 'LANG': 'en_US.UTF-8', 05:49:33 INFO - 'LANGUAGE': 'en_US:en', 05:49:33 INFO - 'LOGNAME': 'cltbld', 05:49:33 INFO - 'MAIL': '/var/mail/cltbld', 05:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:33 INFO - 'MOZ_NO_REMOTE': '1', 05:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:33 INFO - 'NO_EM_RESTART': '1', 05:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:33 INFO - 'PWD': '/builds/slave/test', 05:49:33 INFO - 'SHELL': '/bin/bash', 05:49:33 INFO - 'SHLVL': '1', 05:49:33 INFO - 'TERM': 'linux', 05:49:33 INFO - 'TMOUT': '86400', 05:49:33 INFO - 'USER': 'cltbld', 05:49:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:33 INFO - '_': '/tools/buildbot/bin/python'} 05:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:33 INFO - Running setup.py (path:/tmp/pip-_PUzig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:34 INFO - Running setup.py (path:/tmp/pip-Gw3zAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:34 INFO - Running setup.py (path:/tmp/pip-2d885q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:34 INFO - Running setup.py (path:/tmp/pip-6rX4o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:34 INFO - Running setup.py (path:/tmp/pip-13uSiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:34 INFO - Running setup.py (path:/tmp/pip-BepA_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:34 INFO - Running setup.py (path:/tmp/pip-FeJsAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:34 INFO - Running setup.py (path:/tmp/pip-Z30uNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:34 INFO - Running setup.py (path:/tmp/pip-3Jl0Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:34 INFO - Running setup.py (path:/tmp/pip-MUdIjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:34 INFO - Running setup.py (path:/tmp/pip-trX57A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:34 INFO - Running setup.py (path:/tmp/pip-N1QwST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:34 INFO - Running setup.py (path:/tmp/pip-V73AR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:34 INFO - Running setup.py (path:/tmp/pip-nxB9Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:35 INFO - Running setup.py (path:/tmp/pip-lEZkJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:35 INFO - Running setup.py (path:/tmp/pip-geOWcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:35 INFO - Running setup.py (path:/tmp/pip-TfhQnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:35 INFO - Running setup.py install for manifestparser 05:49:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:35 INFO - Running setup.py install for mozcrash 05:49:35 INFO - Running setup.py install for mozdebug 05:49:35 INFO - Running setup.py install for mozdevice 05:49:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:35 INFO - Running setup.py install for mozfile 05:49:35 INFO - Running setup.py install for mozhttpd 05:49:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:35 INFO - Running setup.py install for mozinfo 05:49:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:35 INFO - Running setup.py install for mozInstall 05:49:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Running setup.py install for mozleak 05:49:36 INFO - Running setup.py install for mozlog 05:49:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Running setup.py install for moznetwork 05:49:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Running setup.py install for mozprocess 05:49:36 INFO - Running setup.py install for mozprofile 05:49:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Running setup.py install for mozrunner 05:49:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Running setup.py install for mozscreenshot 05:49:36 INFO - Running setup.py install for moztest 05:49:36 INFO - Running setup.py install for mozversion 05:49:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:36 INFO - Cleaning up... 05:49:37 INFO - Return code: 0 05:49:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:37 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 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49:37 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 05:49:37 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 05:49:37 INFO - Using env: {'DISPLAY': ':0', 05:49:37 INFO - 'HOME': '/home/cltbld', 05:49:37 INFO - 'LANG': 'en_US.UTF-8', 05:49:37 INFO - 'LANGUAGE': 'en_US:en', 05:49:37 INFO - 'LOGNAME': 'cltbld', 05:49:37 INFO - 'MAIL': '/var/mail/cltbld', 05:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:37 INFO - 'MOZ_NO_REMOTE': '1', 05:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:37 INFO - 'NO_EM_RESTART': '1', 05:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:37 INFO - 'PWD': '/builds/slave/test', 05:49:37 INFO - 'SHELL': '/bin/bash', 05:49:37 INFO - 'SHLVL': '1', 05:49:37 INFO - 'TERM': 'linux', 05:49:37 INFO - 'TMOUT': '86400', 05:49:37 INFO - 'USER': 'cltbld', 05:49:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:37 INFO - '_': '/tools/buildbot/bin/python'} 05:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:37 INFO - Running setup.py (path:/tmp/pip-cZA5Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:37 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)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:37 INFO - Running setup.py (path:/tmp/pip-7YOQEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:37 INFO - Running setup.py (path:/tmp/pip-critNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:37 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)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:37 INFO - Running setup.py (path:/tmp/pip-x4nMPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:37 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)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:37 INFO - Running setup.py (path:/tmp/pip-f92IwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:37 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)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:37 INFO - Running setup.py (path:/tmp/pip-M7RQnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:37 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)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:37 INFO - Running setup.py (path:/tmp/pip-hXbf3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:37 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)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:37 INFO - Running setup.py (path:/tmp/pip-i00xEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:37 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)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:37 INFO - Running setup.py (path:/tmp/pip-eqGQ8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:37 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)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:37 INFO - Running setup.py (path:/tmp/pip-bKfnKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:37 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)) 05:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:37 INFO - Running setup.py (path:/tmp/pip-jUjJjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:38 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)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:38 INFO - Running setup.py (path:/tmp/pip-51Npgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:38 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)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:38 INFO - Running setup.py (path:/tmp/pip-i4WKhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:38 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)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:38 INFO - Running setup.py (path:/tmp/pip-B_yRLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:38 INFO - Running setup.py (path:/tmp/pip-mYH5TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:38 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)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:38 INFO - Running setup.py (path:/tmp/pip-qRwKoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:38 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)) 05:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:38 INFO - Running setup.py (path:/tmp/pip-zTSs1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:38 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)) 05:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:38 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)) 05:49:38 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)) 05:49:38 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)) 05:49:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:38 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 05:49:38 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 05:49:38 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 05:49:38 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 05:49:38 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 05:49:38 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 05:49:40 INFO - Downloading blessings-1.6.tar.gz 05:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:40 INFO - Installing collected packages: blessings 05:49:40 INFO - Running setup.py install for blessings 05:49:40 INFO - Successfully installed blessings 05:49:40 INFO - Cleaning up... 05:49:40 INFO - Return code: 0 05:49:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:40 INFO - Reading from file tmpfile_stdout 05:49:40 INFO - Current package versions: 05:49:40 INFO - argparse == 1.2.1 05:49:40 INFO - blessings == 1.6 05:49:40 INFO - blobuploader == 1.2.4 05:49:40 INFO - docopt == 0.6.1 05:49:40 INFO - functools32 == 3.2.3-2 05:49:40 INFO - jsonschema == 2.5.1 05:49:40 INFO - manifestparser == 1.1 05:49:40 INFO - mozInstall == 1.12 05:49:40 INFO - mozcrash == 1.0 05:49:40 INFO - mozdebug == 0.1 05:49:40 INFO - mozdevice == 0.48 05:49:40 INFO - mozfile == 1.2 05:49:40 INFO - mozhttpd == 0.7 05:49:40 INFO - mozinfo == 0.9 05:49:40 INFO - mozleak == 0.1 05:49:40 INFO - mozlog == 3.4 05:49:40 INFO - moznetwork == 0.27 05:49:40 INFO - mozprocess == 0.23 05:49:40 INFO - mozprofile == 0.28 05:49:40 INFO - mozrunner == 6.13 05:49:40 INFO - mozscreenshot == 0.1 05:49:40 INFO - mozsystemmonitor == 0.3 05:49:40 INFO - moztest == 0.7 05:49:40 INFO - mozversion == 1.4 05:49:40 INFO - psutil == 3.1.1 05:49:40 INFO - requests == 1.2.3 05:49:40 INFO - wsgiref == 0.1.2 05:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49: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 05:49: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 05:49:40 INFO - Using env: {'DISPLAY': ':0', 05:49:40 INFO - 'HOME': '/home/cltbld', 05:49:40 INFO - 'LANG': 'en_US.UTF-8', 05:49:40 INFO - 'LANGUAGE': 'en_US:en', 05:49:40 INFO - 'LOGNAME': 'cltbld', 05:49:40 INFO - 'MAIL': '/var/mail/cltbld', 05:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:40 INFO - 'MOZ_NO_REMOTE': '1', 05:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:40 INFO - 'NO_EM_RESTART': '1', 05:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:40 INFO - 'PWD': '/builds/slave/test', 05:49:40 INFO - 'SHELL': '/bin/bash', 05:49:40 INFO - 'SHLVL': '1', 05:49:40 INFO - 'TERM': 'linux', 05:49:40 INFO - 'TMOUT': '86400', 05:49:40 INFO - 'USER': 'cltbld', 05:49:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:40 INFO - '_': '/tools/buildbot/bin/python'} 05:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49: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)) 05:49: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)) 05:49: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)) 05:49: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)) 05:49: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)) 05:49: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)) 05:49: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)) 05:49: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)) 05:49: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)) 05:49: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)) 05:49: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)) 05:49:41 INFO - Cleaning up... 05:49:41 INFO - Return code: 0 05:49:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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 0x7fafef196e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, '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': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', '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 05:49: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 05:49: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 05:49:41 INFO - Using env: {'DISPLAY': ':0', 05:49:41 INFO - 'HOME': '/home/cltbld', 05:49:41 INFO - 'LANG': 'en_US.UTF-8', 05:49:41 INFO - 'LANGUAGE': 'en_US:en', 05:49:41 INFO - 'LOGNAME': 'cltbld', 05:49:41 INFO - 'MAIL': '/var/mail/cltbld', 05:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:41 INFO - 'MOZ_NO_REMOTE': '1', 05:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:41 INFO - 'NO_EM_RESTART': '1', 05:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:41 INFO - 'PWD': '/builds/slave/test', 05:49:41 INFO - 'SHELL': '/bin/bash', 05:49:41 INFO - 'SHLVL': '1', 05:49:41 INFO - 'TERM': 'linux', 05:49:41 INFO - 'TMOUT': '86400', 05:49:41 INFO - 'USER': 'cltbld', 05:49:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:41 INFO - '_': '/tools/buildbot/bin/python'} 05:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:49:41 INFO - Cleaning up... 05:49:41 INFO - Return code: 0 05:49:41 INFO - Running post-action listener: _resource_record_post_action 05:49:41 INFO - Running post-action listener: _start_resource_monitoring 05:49:41 INFO - Starting resource monitoring. 05:49:41 INFO - [mozharness: 2016-11-17 13:49:41.380668Z] Finished create-virtualenv step (success) 05:49:41 INFO - [mozharness: 2016-11-17 13:49:41.381657Z] Running install step. 05:49:41 INFO - Running pre-action listener: _resource_record_pre_action 05:49:41 INFO - Running main action method: install 05:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:41 INFO - Reading from file tmpfile_stdout 05:49:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:41 INFO - Reading from file tmpfile_stdout 05:49:41 INFO - Output received: 05:49:41 INFO - Usage: mozinstall [options] installer 05:49:41 INFO - Options: 05:49:41 INFO - -h, --help show this help message and exit 05:49:41 INFO - -d DEST, --destination=DEST 05:49:41 INFO - Directory to install application into. [default: 05:49:41 INFO - "/builds/slave/test"] 05:49:41 INFO - --app=APP Application being installed. [default: firefox] 05:49:41 INFO - mkdir: /builds/slave/test/build/application 05:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:49:58 INFO - Reading from file tmpfile_stdout 05:49:58 INFO - Output received: 05:49:58 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:58 INFO - Running post-action listener: _resource_record_post_action 05:49:58 INFO - [mozharness: 2016-11-17 13:49:58.601046Z] Finished install step (success) 05:49:58 INFO - [mozharness: 2016-11-17 13:49:58.601288Z] Running run-tests step. 05:49:58 INFO - Running pre-action listener: _resource_record_pre_action 05:49:58 INFO - Running main action method: run_tests 05:49:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:58 INFO - Python 2.7.3 05:49:58 INFO - Return code: 0 05:49:58 INFO - grabbing minidump binary from tooltool 05:49: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')]} 05:49: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 0x2bf5fc0>, '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 0x2bf6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf7350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49: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 05:49: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 05:49: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 05:49:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:58 INFO - Return code: 0 05:49:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 05:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 05:49:58 INFO - Using env: {'DISPLAY': ':0', 05:49:58 INFO - 'HOME': '/home/cltbld', 05:49:58 INFO - 'LANG': 'en_US.UTF-8', 05:49:58 INFO - 'LANGUAGE': 'en_US:en', 05:49:58 INFO - 'LOGNAME': 'cltbld', 05:49:58 INFO - 'MAIL': '/var/mail/cltbld', 05:49:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:58 INFO - 'MOZ_NO_REMOTE': '1', 05:49:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:58 INFO - 'NO_EM_RESTART': '1', 05:49:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:58 INFO - 'PWD': '/builds/slave/test', 05:49:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:58 INFO - 'SHELL': '/bin/bash', 05:49:58 INFO - 'SHLVL': '1', 05:49:58 INFO - 'TERM': 'linux', 05:49:58 INFO - 'TMOUT': '86400', 05:49:58 INFO - 'USER': 'cltbld', 05:49:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959', 05:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:58 INFO - '_': '/tools/buildbot/bin/python'} 05:49:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 05:49:59 INFO - mozversion application_buildid: 20161117030212 05:49:59 INFO - mozversion application_changeset: 13f49da109ea460665ad27c8497cb1489548450c 05:49:59 INFO - mozversion application_display_name: Nightly 05:49:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:59 INFO - mozversion application_name: Firefox 05:49:59 INFO - mozversion application_remotingname: firefox 05:49:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:49:59 INFO - mozversion application_vendor: Mozilla 05:49:59 INFO - mozversion application_version: 53.0a1 05:49:59 INFO - mozversion platform_buildid: 20161117030212 05:49:59 INFO - mozversion platform_changeset: 13f49da109ea460665ad27c8497cb1489548450c 05:49:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:49:59 INFO - mozversion platform_version: 53.0a1 05:49:59 INFO - using testdate: 1479390599 05:49:59 INFO - actual date: 1479390599 05:49:59 INFO - starting webserver on 'localhost:59822' 05:49:59 INFO - SUITE-START | Running 2 tests 05:49:59 INFO - TEST-START | dromaeo_css 05:49:59 INFO - operating with platform_type : linux_ 05:49:59 INFO - Initialising browser for dromaeo_css test... 05:49:59 INFO - TEST-INFO | started process 3390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3tN_EK/profile http://localhost:59822/getInfo.html) 05:50:05 INFO - PROCESS | 3390 | __metrics Screen width/height:1600/1200 05:50:05 INFO - PROCESS | 3390 | colorDepth:24 05:50:05 INFO - PROCESS | 3390 | Browser inner width/height: 1024/697 05:50:05 INFO - PROCESS | 3390 | __metrics 05:50:06 INFO - PROCESS | 3390 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:50:06 INFO - PROCESS | 3390 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:07 INFO - PROCESS | 3390 | console.error: PushService: 05:50:07 INFO - PROCESS | 3390 | stateChangeProcessEnqueue: Error transitioning state 05:50:07 INFO - PROCESS | 3390 | UnknownError 05:50:07 INFO - TEST-INFO | 3390: exit 0 05:50:07 INFO - Browser initialized. 05:50:07 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:07 INFO - TEST-INFO | started process 3478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3tN_EK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:19 INFO - PROCESS | 3478 | RSS: Main: 173428736 05:50:19 INFO - PROCESS | 3478 | 05:51:11 INFO - PROCESS | 3478 | 1479390671218 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] 05:53:21 INFO - PROCESS | 3478 | Cycle 1(1): loaded http://localhost:59822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59822/tests/dromaeo/cssquery-ext.html) 05:53:24 INFO - PROCESS | 3478 | RSS: Main: 487522304 05:53:24 INFO - PROCESS | 3478 | 05:56:27 INFO - PROCESS | 3478 | Cycle 1(1): loaded http://localhost:59822/tests/dromaeo/cssquery-ext.html (next: http://localhost:59822/tests/dromaeo/cssquery-jquery.html) 05:56:27 INFO - PROCESS | 3478 | RSS: Main: 287879168 05:56:27 INFO - PROCESS | 3478 | 05:59:29 INFO - PROCESS | 3478 | Cycle 1(1): loaded http://localhost:59822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59822/tests/dromaeo/cssquery-mootools.html) 05:59:30 INFO - PROCESS | 3478 | RSS: Main: 222081024 05:59:30 INFO - PROCESS | 3478 | 06:02:32 INFO - PROCESS | 3478 | Cycle 1(1): loaded http://localhost:59822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59822/tests/dromaeo/cssquery-prototype.html) 06:02:33 INFO - PROCESS | 3478 | RSS: Main: 220364800 06:02:33 INFO - PROCESS | 3478 | 06:05:36 INFO - PROCESS | 3478 | Cycle 1(1): loaded http://localhost:59822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59822/tests/dromaeo/cssquery-yui.html) 06:05:36 INFO - PROCESS | 3478 | RSS: Main: 220786688 06:05:36 INFO - PROCESS | 3478 | 06:08:39 INFO - PROCESS | 3478 | Cycle 1(1): loaded http://localhost:59822/tests/dromaeo/cssquery-yui.html (next: http://localhost:59822/tests/dromaeo/cssquery-dojo.html) 06:08:39 INFO - PROCESS | 3478 | RSS: Main: 311062528 06:08:39 INFO - PROCESS | 3478 | 06:08:39 INFO - PROCESS | 3478 | __start_tp_report 06:08:39 INFO - PROCESS | 3478 | _x_x_mozilla_page_load 06:08:39 INFO - PROCESS | 3478 | _x_x_mozilla_page_load_details 06:08:39 INFO - PROCESS | 3478 | |i|pagename|runs| 06:08:39 INFO - PROCESS | 3478 | |0;dojo.html;3009.0371081253993;3053.7098975597337;3080.5533197686336;3092.9072127836157;3095.752339812815;5207.401148867882;5248.973755131219;5252.6848389096685;5279.683219006863;5334.466553344669;5280.1815718563585;5357.303550538434;5358.169483730028;5359.866003349918;5434.592405569579;4776.450708168553;4776.522347765231;4808.230683090706;4844.636652251078;4857.562819346258;4886.877828054292;4908;4983.700977941335;4994.950050499503;5032.6477146599755;4894.755262236874;4901.044296362211;4947.332110165117;4954.925676114861;4980.800767969277;4728.4562275338085;4755.643326750507;4761.547652972962;4795.448523419816;4825.9034819303415;4777.140114779339;4778.044391121754;4799.256115302133;4801.1117943180625;4804.975975120137;5206.297149884755;5243.370795504526;5246.658967167122;5262.394824595182;5274.077036518633;5551.694656793875;5570.721463926828;5574.247476590649;5584.0507113790345;5605.579581531401;5599.356074051496;5662.971685141589;5663.9716801415725;5669;5674;5242.325971762157;5267.815626453055;5321.388040375329;5376.166694162372;5383.623146379755;5742.08126699726;5758;5765.711714414262;5770.538356931435;5770.567207459458;5430.972845135828;5526.281583394133;5548.750306236229;5553.444655534414;5553.861153471114;5521.061419558604;5599.636023658449;5600.6919619420505;5661.801836935688;5665.405132461115;5675.091985282335;5682.431756824284;5684.801031963944;5687.772489100473;5729.713514324267;5683.062294721407;5695.800646977419;5696.031674615326;5708.828735137952;5732.914006289909;4251.9787401062795;4304.935425968613;4315.762633055212;4347.717398369159;4348.195583817004;3836.501254836853;3896.59085795993;3897.2595206910596;3913.295606790748;3916.784576848244;5392.676439413648;5398.757055932492;5408.378036525771;5410.891782164414;5413.188021796684;5726.484616384545;5737.741801618937;5739.397363276796;5744.626599271034;5770.365259821417;5286.60350473716;5287.576993840484;5346.358436987586;5403.972980135074;5414.458554144633;4721.834735784231;4790.952090479121;4797.976010119927;4800.159972004885;4808.567228949341;5901.0558310670085;5913.497352724895;5914.378990206053;5914.852128696731;5916.497097746654;5706.80026199081;5722.484976352148;5730.942690573041;5734.5125664319;5736.282964629421;5898.056310990221;5914.024186009432;5915.58590898633;5916.230889984275;5923.052311630118;5636.2954630671165;5651.88696226065;5653.067243904709;5654.264945557051;5656.915146272727;5681.914771278517;5685.971570142123;5692.117721753135;5750.856228594319;5763;5625.09998400254;5633.802816901389;5648.096304591246;5657.405972373006;5658.717064146858;5403.4326395727885;5473.890522189614;5474.3704473986;5621.578381621476;5629.408912064175;5420.83737487876;5531.529819965187;5537.390887002346;5537.944620553904;5546.4453554644215;5565.6104072714525;5591.748371323381;5593.496585307342;5599.272094627672;5601.439856014366;5420.593455490933;5432.538234249975;5477.507024367666;5491.807786727445;5567.331920169606 06:08:39 INFO - PROCESS | 3478 | |1;ext.html;590.4036922708065;607.1924340626965;619.1053927075378;630.1807650054925;646.789793317172;26911.865440672795;33638.66361336386;34394.484082738745;34460.1384965376;36347.63652363482;34480.1379965501;34770.8261458693;34792.65207347926;34903.82548087256;34906;6772.7629532966475;6922.996165556016;6931.272216417279;6934.722611095575;6935.687894044755;5971.790987315445;6102.5117990560875;7009.929900700979;7207.603581802999;7209.531380460253;7195.316444937749;7242.529235599669;7243.529170603921;7243.927560724404;7244.891326630105;7169.139703235593;7222.855542889165;7230.421566274686;7230.638468076628;7234.529755565898;7253;7299.854002919912;7312.744053958139;7315.9634201829185;7316.414686825041;32219.6778032219;32532.837335813405;32538.511922321184;32539.6746032539;32540.837295813606;3331.4669652855428;3360.9159771005675;3512.7892326460496;3718.3307004739136;4028.939565906514;23072.653910191362;23354;23851.284461466184;23896;24134.879325603437;3604.189057462076;3643.9271214575824;3649.4708267301357;3712.684421824148;3752.418375151856;340012;340712;341017;342464;342952.8423094424;34086.48870266948;34949.30101398009;58150.709246454346;58537.1706234348;58632.120518191405;36574.085647859014;36960;37012;37014.81492592573;37033;14256.287185640676;14306.57080287593;14376.568702938928;14376.928115359357;14421.20683362404;10982.121430285717;11263.774724505463;11894;12001.87998120025;12013.939930300292;8195.34437245019;8244.793880153044;8252.711155109542;8526.701565445179;8529.872051919227;3231.579894613732;3260.3153337799326;3271.7915407100113;3280.048785852076;3289.358575077885;945.3618807305041;1000.1898462245605;1009.2178561614661;1082.3451811653993;1089.5600428254736;29335.706642933725;31276.687233127832;31488.685113148575;31645.683543164734;32117.839410802797;1094.2067001423904;1110.655696734015;1129.7062763681338;1157.3518829455531;1165.6328256599145;15531.611709707347;16380.426685066204;16388.590285242964;16428.835711642732;16662.750058749127;746706;760706;761733;762416;762844;52498.73750631222;53252.73373633107;53269.46730532645;53330.73334633379;53350.73324633352;1304.4064950447714;1338.056670047614;1338.2840180503579;1344.9125806822526;1357.762391581489;29510.262243444085;31008.68991310058;31246.531302030944;31299.84350078235;31526.369472610877;50623.24065138952;51131.48868511267;51164;51169;51244.487555123975;442237;443383;447633;448352;450251;27101.322466938484;27296;27349.589756153277;27648.861755691094;27743.86128069347;42371.364429532965;42765.78617107019;43212.35181472218;43251.134977300906;43269;36001.63998359983;36658.8167059163;36996.745374282305;37510.43734343933;37717.62282377141;36027.81986090053;37274.627253727114;37394.813025935786;37533.2493350126;37600.62399375971;37830;38299.23401532009;38847.863367515056;38874;39201.607983920934;32578.51132232971;34092.14769630779;34714.65285347114;34796.30407391889;34947.825260873535;26757;27096.79995607524;27227.72772272252;27255.59116613292;27258.454830902876 06:08:39 INFO - PROCESS | 3478 | |2;jquery.html;358.11188253132246;373.21438372226464;381.1823638295855;386.89747216987496;408.1327179743046;12295.569655062063;12980.415881285342;13529.323533823293;15804.051756894594;16209.108499032549;17061.658766824658;17759.378421755242;18097;18369.173387197574;18587.721184182214;4869.220924652056;5184.144616138352;5185.144451165553;5189.169732842746;5191.273221748958;3551.68034876861;3656.3235801376695;5061.848144555669;5157.355330583677;5171.534561889429;3713.2016616427463;5082.466341034194;5102.821401250957;5146.099432599281;5149.716765577892;4912.214045752698;5091.956148989449;5141.948580514184;5144.0740666679985;5150.072986862363;4552.521985191574;4581.358609794632;4584.174848527264;4584.88537786558;4585.3122031695175;15967;16082.276297566637;17799.555011124827;19286.807131928643;19435.514112147168;2293.6788849561076;2360.468894498741;2376.040760531875;2471.8146139039645;2941.529355303141;12237.449314780857;12482.563110291096;12774.61676149717;13091.607251782367;13300.201987880759;1699.9150042497827;1712.725963845791;1714.5370749897584;1743.9651206975789;1778.644271145763;80087.5995620024;82253.58873205596;82813.58593207055;84017.57991210066;85482;10049.397036177852;10097.798044039078;10315.74210644725;10403.479826008821;10687.30532515384;14780.187089709954;14796.408143674133;14815.555533334018;14817.925910370379;14829.62925926839;7589.772306830693;7874.56689882062;7885.369170466349;8135.471194372347;8155.551444670481;7511.51175173612;7553.660085296175;7620.809479762939;7814.101378341564;7901.091374492007;6373.52198585108;6459.870802584016;6482.319356467598;6492.67536623167;6660.933390666129;1794.883332583378;1828.1955939386894;1885.8397036252072;1887.9528011799541;1898.2881419467699;1000.1798525209258;1021.6373187518473;1063.707480442869;1066.2429674930886;1091.8362245663213;19593.608127837364;20010.499737506678;20106.396808095487;20198.39404817858;20549.76701397921;982.7543114221445;1011.3577878047493;1013.7566983923805;1015.21320976244;1027.9691609251734;10945.781084378268;11270.774584508265;11323.830142547868;11417.771644567061;11422.885771142182;350369;352138;352237;456808;487820;100777;101377.49311253396;103075;103520.48239758753;106162;965.1554889471712;984.5028260728286;1030.5620111452602;1034.8447732840134;1038.1694644284694;16600.916995415428;16646.751493637785;16711;17216.569585760455;17918.104094795468;41332.79333603313;42408;42671;43193.35209971916;44834;61171.694141529006;62137.378626214966;63136.36863631305;63431.6828415855;63499;8353.624086915981;8377.95811020941;8519.148085191431;8543.40196186261;8772.605232764668;11030.950435458388;12442.440090195782;12721.93639031799;13038.869611303766;13479.595612131652;10569.735756606146;10793.67618971432;10861.45692715377;11572.6528204154;11602.187846850977;10871.945640271748;11229.438528073728;11256.324620522795;11284.661460156209;11441.313521188755;11219.587788625484;11440.656780296604;11593.246438981776;11646.534138634699;11919.106067045179;7746.264104910025;7889.6449659766595;7909.960450197942;8329.916700832913;8599.183077607617;8564.527191578782;11307;11430.885691142983;11864.644060678194;11932.747061558759 06:08:39 INFO - PROCESS | 3478 | |3;mootools.html;1280.5070048031516;1388.4931999820064;1405.6977749783798;1477.9630509237268;1663.0603708904475;6444.935550644492;6932.480063995202;7163.89254161188;7173.246809085049;7316.231795661459;7205.495615306918;7277.781666550012;7280.089988751406;7281.817954551138;7286.089238845145;2001.149511457632;2036.745406824147;2041.2753472517265;2042.0402410866868;2043.019350711652;2014.4661664658877;2032.5325175209637;2040.6122836660986;2085.4786303424144;2086.6139764143604;1999.2502811445709;2000.6998950157447;2025.2202901882808;2026.4224695961655;2027.1688607670858;1983.226541648758;1995.4213278149464;2000.2898970865278;2005.3081686818098;2009.9095540700703;1919.1555715485142;1933.4296382567177;1996.440996520962;2001.9299324523718;2003.3989803059023;6945;7194.424446044304;7204.567725936408;7256.963715181443;7259.056322678018;4817.927731084036;4951.727654978975;4957.950420495785;4959.677620954626;4967.528084831935;3097.148284221857;3252.349530093991;3261.96738032619;3330.6003279606603;3338.5159151923076;1033.7415646088477;1043.2957753516346;1066.3335415365398;1084.3385534823751;1084.4631907205905;10004.549795259158;10017.298789084767;10095.343802652804;10104.292699511037;10121.392716436963;3897.785621790772;4112.856050038235;4174.812133454002;4188.183304255702;4254.42565253693;8169.183081691902;8169.346452283803;8176.509409435453;8199.631016604268;8202.876956845652;4832.130216561053;4833.419989601271;4833.9033219335415;4836.951630483721;4837.32277481153;3815.198808250243;3971.245463361952;4146.481689788777;4542;4542.931856022163;3457;3480.216951185963;3588.766730162531;3596.9640303597153;3603.2253065591026;1126.245415571569;1137.0676045642658;1142.491591241906;1143.2740209966564;1165.056304393444;804.8651401523823;896.6547879066476;899.6086702284528;924.4591913730409;925.2551695884742;5188.81839135636;5238.7904483820985;5393.568514518907;5462.590305727086;5469.234307196995;450.9774511274423;463.2657238277368;464.40092280957185;466.64534953435634;466.8109415686652;3681.9079523011605;3750.1749615084636;3754.455603937414;3771.113788259757;3880.3791393376923;8804.427712198814;9034.2320902724;9130.817383652422;9134.314926380415;9144.131307525775;8477.152284771473;9091.909080909107;9104.271658267322;9104.362694611445;9105.089491050841;6752.864942701119;7005.439564834801;7057.964710176417;7079.327463890922;7094.893576596355;4996.550310472075;5094.974525127351;5111.207762796624;5140.948590514196;5365.704886231295;8394.454360466794;8522.27560657351;8523;8585.141485851615;8593.785155371166;7708.8458230836195;8015.318697910509;8347.624356903832;8489.87265191035;8536.189062039097;5945.672987985529;6403.615783053032;6545.37818907203;6635.8009259722285;6641.435477984425;6883.931160688529;7169.749058782918;7240.420766338786;7318.96340518294;7329.670164842488;6289.182406287154;6327.873442531216;6356.364363563792;6417.8716425672155;6647.534672572873;6389.680515974275;6513.348665133449;6585.80242592723;6655.267920528641;6690.899636505359;6056.9697151513965;6137.815865524041;6179.721912513858;6182.629042257479;6188.783392581238;4512.774361281989;4612.354270402079;4631.216981462094;4664.673472856867;4726.243800991825;4699.859004229878;4714.38712967312;4773.403324584427;4795.544423279783;4859.854204373874 06:08:39 INFO - PROCESS | 3478 | |4;prototype.html;326.96730326967304;331.2084118955696;333.9515770213319;339.14704518136875;339.28749625785855;5220.895582088356;5315.202719592063;5318.175682769172;5322.414534401218;5334.413214546396;5229.241759944805;5235.450277720842;5255.76349064292;5256.94861027794;5269.314989051428;3887.2225554888996;4001.539822920358;4061.878143655695;4069.0671930832914;4123.257813593552;4123.464069597191;4126.504819421659;4154.400555786014;4156.8129434175535;4164.541900390955;4070.4911886014247;4081.1837632473475;4100.487439070116;4111.075008123178;4142.440770495989;3743.8315275812383;3881.9029524261837;3967.7817720025387;4154.875353739378;4182.545588947761;3686.944695829565;3699.0012696572044;3699.7780133192095;3701.3152566775234;3701.7593856399517;5135.279681306767;5135.356685860526;5154.871128221787;5161.251618515332;5187.559057480119;4674.7093923977345;4699.929501057487;4752.7861246244;4761.190597598416;4763.809447622091;5531.363893152299;5532.944670553283;5535.723213839292;5540.50135487804;5540.750666220029;4066.3900414937702;4071.8982025449304;4074.6536544393466;4081.4694089768436;4084.305668036441;5481.232627432163;5736.2256095427;5737.885242295172;5787.797427090074;5788.739506722208;4066.3087275163293;4072.2466343726505;4073.857414990461;4085.264652362544;4085.89785255371;4071.816768245436;4085.89785255371;4094.3653733671326;4136.710430269913;4142.192272506893;4515.9774201128785;4664.976675116603;4665.790039448233;4674.288912430782;4683.367745354333;5530.50676317392;5553.723303251101;5560.471755183251;5562.3047119110115;5563.833085007456;1367.7196174784146;1379.048456564967;1382.5921353200629;1384.2732565403244;1387.7502049631164;889.3241136735998;909.7680091576738;944.2964991081551;944.5702205496483;952.72810797586;5314.229436731653;5329.467053294639;5341.65279256847;5352.678839269656;5357.651752636066;5665.232620307532;5689.2319536862;5695.829125126253;5709.68596727184;5716.828050249689;5131.974340128276;5305.363356397257;5339.145736682112;5343.62594618373;5368.194770784336;2871.8420486873424;2881.7982741208334;2885.701434354507;2894.522403803349;2895.6959519250177;5630.354957160359;5647.989927151768;5657.688827114548;5660.15097735343;5663.235463212496;5307.761150748225;5509.862253443615;5567.8886422272135;5578.414266501959;5611.859703507445;5589.664620122806;5603.719814009365;5614.943850561442;5622.987862184846;5675.489205971482;5260.947390526198;5453;5454.154606036071;5471.398146203994;5492.253873063468;5394.543473262275;5396.865078373072;5400.378956419905;5406.621536492565;5427.755750991294;5537.36320323168;5571.629164355669;5579.693116878449;5605.32736071674;5607.80372686954;3776.2825063237897;3905.941410878896;3907.57016728154;3921;3928.2929072767174;5419.96481970098;5439.891202175855;5445.618806683494;5461.644993075437;5465.9726701366235;5336.279602253646;5345.33183352081;5448.256557901434;5460.290162278879;5474.698891561003;5074.594032477319;5282.260483532232;5327.627066105335;5337.386200586827;5351.678899266057;5253.632245742914;5314.362276526842;5326.789382406258;5331.3868905076415;5355.651882627617;5394.9730251350065;5431.646942948696;5552.222688823487;5567.498925096761;5596.41237670055;5374.462553744751;5407.675539467645;5409.350877894678;5410.404855465974;5454.154606036071 06:08:39 INFO - PROCESS | 3478 | |5;yui.html;705.5272967112036;729.5258082246539;764.0029761161685;778.3073064972174;784.2706283156662;11936.522539098436;12611.684707882308;12642.36788160593;12673;12748.681282967931;12909.612711618667;13128.671783205426;13153.145045572031;13160.27618480983;13162.07865449419;624.9656268905209;642.7364780440021;726.2628432141381;736.8673638745024;748.8127968007998;740.5038624121825;745.5265906149607;753.1338960195791;753.1827966656184;753.3333000294751;782.0654318089885;783.2011348424631;786.7364432914952;786.8072322281049;787.6731156570016;641.8459569703284;662.6322391072953;781.9921800782005;782.2763943352405;782.3076577229136;554.7226386806597;570.6490508337342;572.364675210516;572.6363759013016;572.7107810555643;11147.275427097295;11189.720256993558;11196.10431165513;11209.943950280196;11210.327380357205;10545.630902918438;10592.364458132537;11175.776484470265;11281;11572.074234061254;9615.807683846353;9643.180329671986;9898.406095634286;9898.653547125889;9911.90088099117;3041.1788817019283;3054.328047829496;3069.478188707925;3075.861586228625;3137.043201823443;57454;58495;61907.7852154394;62185.689071554356;64133.3586664132;8312;8371.95814020926;8378.916210837813;8421.621027053798;8593.871091933626;15452.5364239073;15458.304376303093;15470.303836327392;15552.455664051704;15554.9222253888;7778.611069446505;7849.725259615886;7868;7972.720954766555;8108.878366824502;4398.582134697199;4425.690201685916;4507.278835386388;4563.680542362003;4568.954310456919;3232.2242661761006;3321;3321.9833900830827;3322.5182348559806;3330.816805075696;561.8511094559944;562.2858969109209;577.0363492966756;582.860113572748;589.4547543522225;587.0284678856499;596.1951365656329;653.2362867321913;656.7799787071384;664.6391217268767;8161.918380816234;8517.531535765593;8666.86999695005;8671.21959023691;8859.025507194203;549.7388740348302;586.9031609784423;627.4415769964735;637.2452008707753;665.2582370656683;4188.308929026737;4214.178235244098;4319.546447623017;4429.269170586882;4541.72749635023;51004;51854.22218666723;51872.22191667128;65161;74101;69695;71970.64014679893;72380.91428628574;73411.2658873415;74275;60238;66217.66891165513;66703.33296666971;66830;68094.65952670304;7400.370968467741;7829.177936316605;7911.802204944692;8008.919910801051;8340;43388.78305608452;43647.56352436435;44780.77609611931;45162.32256516089;46335.768321158175;57148.428515715976;62278.68860655668;62655.37344626495;62837.37162628315;64709;9930.602775889172;10080.495975201356;10095.545700443645;10288.382697038202;10312.535935882754;10794.190435717195;10849.783004340026;11056.502457389597;11125.610603628835;11230.21388502797;10087.193024557871;10162.288639795144;10839.187060970302;10931.781364372828;11119.666410007712;11049.28179668319;11290.943545282222;11511.19421640477;11555;11896.583619573274;10726.463676815973;11115.444227788417;11120.888791111985;11458.656240312805;11458.82811757841;8370.790730231793;8622.439541429787;8758.343124265579;8907.198352148338;8954.194122529003;7888.566128862968;7905.881411778713;7990;8351.707690231056;8587.527685977082 06:08:39 INFO - PROCESS | 3478 | __end_tp_report 06:08:39 INFO - PROCESS | 3478 | __start_cc_report 06:08:39 INFO - PROCESS | 3478 | _x_x_mozilla_cycle_collect,3135 06:08:39 INFO - PROCESS | 3478 | __end_cc_report 06:08:39 INFO - PROCESS | 3478 | __startTimestamp1479391719679__endTimestamp 06:08:39 INFO - PROCESS | 3478 | 06:08:39 INFO - PROCESS | 3478 | ------- Summary: start ------- 06:08:39 INFO - PROCESS | 3478 | Number of tests: 6 06:08:39 INFO - PROCESS | 3478 | 06:08:39 INFO - PROCESS | 3478 | [#0] dojo.html Cycles:165 Average:5278.80 Median:5477.51 stddev:602.60 (11.0%) stddev-sans-first:577.55 06:08:39 INFO - PROCESS | 3478 | Values: 3009.0 3053.7 3080.6 3092.9 3095.8 5207.4 5249.0 5252.7 5279.7 5334.5 5280.2 5357.3 5358.2 5359.9 5434.6 4776.5 4776.5 4808.2 4844.6 4857.6 4886.9 4908.0 4983.7 4995.0 5032.6 4894.8 4901.0 4947.3 4954.9 4980.8 4728.5 4755.6 4761.5 4795.4 4825.9 4777.1 4778.0 4799.3 4801.1 4805.0 5206.3 5243.4 5246.7 5262.4 5274.1 5551.7 5570.7 5574.2 5584.1 5605.6 5599.4 5663.0 5664.0 5669.0 5674.0 5242.3 5267.8 5321.4 5376.2 5383.6 5742.1 5758.0 5765.7 5770.5 5770.6 5431.0 5526.3 5548.8 5553.4 5553.9 5521.1 5599.6 5600.7 5661.8 5665.4 5675.1 5682.4 5684.8 5687.8 5729.7 5683.1 5695.8 5696.0 5708.8 5732.9 4252.0 4304.9 4315.8 4347.7 4348.2 3836.5 3896.6 3897.3 3913.3 3916.8 5392.7 5398.8 5408.4 5410.9 5413.2 5726.5 5737.7 5739.4 5744.6 5770.4 5286.6 5287.6 5346.4 5404.0 5414.5 4721.8 4791.0 4798.0 4800.2 4808.6 5901.1 5913.5 5914.4 5914.9 5916.5 5706.8 5722.5 5730.9 5734.5 5736.3 5898.1 5914.0 5915.6 5916.2 5923.1 5636.3 5651.9 5653.1 5654.3 5656.9 5681.9 5686.0 5692.1 5750.9 5763.0 5625.1 5633.8 5648.1 5657.4 5658.7 5403.4 5473.9 5474.4 5621.6 5629.4 5420.8 5531.5 5537.4 5537.9 5546.4 5565.6 5591.7 5593.5 5599.3 5601.4 5420.6 5432.5 5477.5 5491.8 5567.3 06:08:39 INFO - PROCESS | 3478 | 06:08:39 INFO - PROCESS | 3478 | [#1] ext.html Cycles:180 Average:62998.05 Median:19975.91 stddev:147018.29 (736.0%) stddev-sans-first:147356.04 06:08:39 INFO - PROCESS | 3478 | Values: 590.4 607.2 619.1 630.2 646.8 26911.9 33638.7 34394.5 34460.1 36347.6 34480.1 34770.8 34792.7 34903.8 34906.0 6772.8 6923.0 6931.3 6934.7 6935.7 5971.8 6102.5 7009.9 7207.6 7209.5 7195.3 7242.5 7243.5 7243.9 7244.9 7169.1 7222.9 7230.4 7230.6 7234.5 7253.0 7299.9 7312.7 7316.0 7316.4 32219.7 32532.8 32538.5 32539.7 32540.8 3331.5 3360.9 3512.8 3718.3 4028.9 23072.7 23354.0 23851.3 23896.0 24134.9 3604.2 3643.9 3649.5 3712.7 3752.4 340012.0 340712.0 341017.0 342464.0 342952.8 34086.5 34949.3 58150.7 58537.2 58632.1 36574.1 36960.0 37012.0 37014.8 37033.0 14256.3 14306.6 14376.6 14376.9 14421.2 10982.1 11263.8 11894.0 12001.9 12013.9 8195.3 8244.8 8252.7 8526.7 8529.9 3231.6 3260.3 3271.8 3280.0 3289.4 945.4 1000.2 1009.2 1082.3 1089.6 29335.7 31276.7 31488.7 31645.7 32117.8 1094.2 1110.7 1129.7 1157.4 1165.6 15531.6 16380.4 16388.6 16428.8 16662.8 746706.0 760706.0 761733.0 762416.0 762844.0 52498.7 53252.7 53269.5 53330.7 53350.7 1304.4 1338.1 1338.3 1344.9 1357.8 29510.3 31008.7 31246.5 31299.8 31526.4 50623.2 51131.5 51164.0 51169.0 51244.5 442237.0 443383.0 447633.0 448352.0 450251.0 27101.3 27296.0 27349.6 27648.9 27743.9 42371.4 42765.8 43212.4 43251.1 43269.0 36001.6 36658.8 36996.7 37510.4 37717.6 36027.8 37274.6 37394.8 37533.2 37600.6 37830.0 38299.2 38847.9 38874.0 39201.6 32578.5 34092.1 34714.7 34796.3 34947.8 26757.0 27096.8 27227.7 27255.6 27258.5 06:08:39 INFO - PROCESS | 3478 | 06:08:39 INFO - PROCESS | 3478 | [#2] jquery.html Cycles:180 Average:26591.58 Median:19514.56 stddev:67796.49 (347.4%) stddev-sans-first:67958.06 06:08:39 INFO - PROCESS | 3478 | Values: 358.1 373.2 381.2 386.9 408.1 12295.6 12980.4 13529.3 15804.1 16209.1 17061.7 17759.4 18097.0 18369.2 18587.7 4869.2 5184.1 5185.1 5189.2 5191.3 3551.7 3656.3 5061.8 5157.4 5171.5 3713.2 5082.5 5102.8 5146.1 5149.7 4912.2 5092.0 5141.9 5144.1 5150.1 4552.5 4581.4 4584.2 4584.9 4585.3 15967.0 16082.3 17799.6 19286.8 19435.5 2293.7 2360.5 2376.0 2471.8 2941.5 12237.4 12482.6 12774.6 13091.6 13300.2 1699.9 1712.7 1714.5 1744.0 1778.6 80087.6 82253.6 82813.6 84017.6 85482.0 10049.4 10097.8 10315.7 10403.5 10687.3 14780.2 14796.4 14815.6 14817.9 14829.6 7589.8 7874.6 7885.4 8135.5 8155.6 7511.5 7553.7 7620.8 7814.1 7901.1 6373.5 6459.9 6482.3 6492.7 6660.9 1794.9 1828.2 1885.8 1888.0 1898.3 1000.2 1021.6 1063.7 1066.2 1091.8 19593.6 20010.5 20106.4 20198.4 20549.8 982.8 1011.4 1013.8 1015.2 1028.0 10945.8 11270.8 11323.8 11417.8 11422.9 350369.0 352138.0 352237.0 456808.0 487820.0 100777.0 101377.5 103075.0 103520.5 106162.0 965.2 984.5 1030.6 1034.8 1038.2 16600.9 16646.8 16711.0 17216.6 17918.1 41332.8 42408.0 42671.0 43193.4 44834.0 61171.7 62137.4 63136.4 63431.7 63499.0 8353.6 8378.0 8519.1 8543.4 8772.6 11031.0 12442.4 12721.9 13038.9 13479.6 10569.7 10793.7 10861.5 11572.7 11602.2 10871.9 11229.4 11256.3 11284.7 11441.3 11219.6 11440.7 11593.2 11646.5 11919.1 7746.3 7889.6 7910.0 8329.9 8599.2 8564.5 11307.0 11430.9 11864.6 11932.7 06:08:39 INFO - PROCESS | 3478 | 06:08:39 INFO - PROCESS | 3478 | [#3] mootools.html Cycles:180 Average:4939.90 Median:4905.79 stddev:2670.53 (54.4%) stddev-sans-first:2663.86 06:08:39 INFO - PROCESS | 3478 | Values: 1280.5 1388.5 1405.7 1478.0 1663.1 6444.9 6932.5 7163.9 7173.2 7316.2 7205.5 7277.8 7280.1 7281.8 7286.1 2001.1 2036.7 2041.3 2042.0 2043.0 2014.5 2032.5 2040.6 2085.5 2086.6 1999.3 2000.7 2025.2 2026.4 2027.2 1983.2 1995.4 2000.3 2005.3 2009.9 1919.2 1933.4 1996.4 2001.9 2003.4 6945.0 7194.4 7204.6 7257.0 7259.1 4817.9 4951.7 4958.0 4959.7 4967.5 3097.1 3252.3 3262.0 3330.6 3338.5 1033.7 1043.3 1066.3 1084.3 1084.5 10004.5 10017.3 10095.3 10104.3 10121.4 3897.8 4112.9 4174.8 4188.2 4254.4 8169.2 8169.3 8176.5 8199.6 8202.9 4832.1 4833.4 4833.9 4837.0 4837.3 3815.2 3971.2 4146.5 4542.0 4542.9 3457.0 3480.2 3588.8 3597.0 3603.2 1126.2 1137.1 1142.5 1143.3 1165.1 804.9 896.7 899.6 924.5 925.3 5188.8 5238.8 5393.6 5462.6 5469.2 451.0 463.3 464.4 466.6 466.8 3681.9 3750.2 3754.5 3771.1 3880.4 8804.4 9034.2 9130.8 9134.3 9144.1 8477.2 9091.9 9104.3 9104.4 9105.1 6752.9 7005.4 7058.0 7079.3 7094.9 4996.6 5095.0 5111.2 5140.9 5365.7 8394.5 8522.3 8523.0 8585.1 8593.8 7708.8 8015.3 8347.6 8489.9 8536.2 5945.7 6403.6 6545.4 6635.8 6641.4 6883.9 7169.7 7240.4 7319.0 7329.7 6289.2 6327.9 6356.4 6417.9 6647.5 6389.7 6513.3 6585.8 6655.3 6690.9 6057.0 6137.8 6179.7 6182.6 6188.8 4512.8 4612.4 4631.2 4664.7 4726.2 4699.9 4714.4 4773.4 4795.5 4859.9 06:08:39 INFO - PROCESS | 3478 | 06:08:39 INFO - PROCESS | 3478 | [#4] prototype.html Cycles:180 Average:4594.76 Median:5316.69 stddev:1336.67 (25.1%) stddev-sans-first:1301.47 06:08:39 INFO - PROCESS | 3478 | Values: 327.0 331.2 334.0 339.1 339.3 5220.9 5315.2 5318.2 5322.4 5334.4 5229.2 5235.5 5255.8 5256.9 5269.3 3887.2 4001.5 4061.9 4069.1 4123.3 4123.5 4126.5 4154.4 4156.8 4164.5 4070.5 4081.2 4100.5 4111.1 4142.4 3743.8 3881.9 3967.8 4154.9 4182.5 3686.9 3699.0 3699.8 3701.3 3701.8 5135.3 5135.4 5154.9 5161.3 5187.6 4674.7 4699.9 4752.8 4761.2 4763.8 5531.4 5532.9 5535.7 5540.5 5540.8 4066.4 4071.9 4074.7 4081.5 4084.3 5481.2 5736.2 5737.9 5787.8 5788.7 4066.3 4072.2 4073.9 4085.3 4085.9 4071.8 4085.9 4094.4 4136.7 4142.2 4516.0 4665.0 4665.8 4674.3 4683.4 5530.5 5553.7 5560.5 5562.3 5563.8 1367.7 1379.0 1382.6 1384.3 1387.8 889.3 909.8 944.3 944.6 952.7 5314.2 5329.5 5341.7 5352.7 5357.7 5665.2 5689.2 5695.8 5709.7 5716.8 5132.0 5305.4 5339.1 5343.6 5368.2 2871.8 2881.8 2885.7 2894.5 2895.7 5630.4 5648.0 5657.7 5660.2 5663.2 5307.8 5509.9 5567.9 5578.4 5611.9 5589.7 5603.7 5614.9 5623.0 5675.5 5260.9 5453.0 5454.2 5471.4 5492.3 5394.5 5396.9 5400.4 5406.6 5427.8 5537.4 5571.6 5579.7 5605.3 5607.8 3776.3 3905.9 3907.6 3921.0 3928.3 5420.0 5439.9 5445.6 5461.6 5466.0 5336.3 5345.3 5448.3 5460.3 5474.7 5074.6 5282.3 5327.6 5337.4 5351.7 5253.6 5314.4 5326.8 5331.4 5355.7 5395.0 5431.6 5552.2 5567.5 5596.4 5374.5 5407.7 5409.4 5410.4 5454.2 06:08:39 INFO - PROCESS | 3478 | 06:08:39 INFO - PROCESS | 3478 | [#5] yui.html Cycles:180 Average:15631.38 Median:586.97 stddev:21023.00 (3581.6%) stddev-sans-first:21052.10 06:08:39 INFO - PROCESS | 3478 | Values: 705.5 729.5 764.0 778.3 784.3 11936.5 12611.7 12642.4 12673.0 12748.7 12909.6 13128.7 13153.1 13160.3 13162.1 625.0 642.7 726.3 736.9 748.8 740.5 745.5 753.1 753.2 753.3 782.1 783.2 786.7 786.8 787.7 641.8 662.6 782.0 782.3 782.3 554.7 570.6 572.4 572.6 572.7 11147.3 11189.7 11196.1 11209.9 11210.3 10545.6 10592.4 11175.8 11281.0 11572.1 9615.8 9643.2 9898.4 9898.7 9911.9 3041.2 3054.3 3069.5 3075.9 3137.0 57454.0 58495.0 61907.8 62185.7 64133.4 8312.0 8372.0 8378.9 8421.6 8593.9 15452.5 15458.3 15470.3 15552.5 15554.9 7778.6 7849.7 7868.0 7972.7 8108.9 4398.6 4425.7 4507.3 4563.7 4569.0 3232.2 3321.0 3322.0 3322.5 3330.8 561.9 562.3 577.0 582.9 589.5 587.0 596.2 653.2 656.8 664.6 8161.9 8517.5 8666.9 8671.2 8859.0 549.7 586.9 627.4 637.2 665.3 4188.3 4214.2 4319.5 4429.3 4541.7 51004.0 51854.2 51872.2 65161.0 74101.0 69695.0 71970.6 72380.9 73411.3 74275.0 60238.0 66217.7 66703.3 66830.0 68094.7 7400.4 7829.2 7911.8 8008.9 8340.0 43388.8 43647.6 44780.8 45162.3 46335.8 57148.4 62278.7 62655.4 62837.4 64709.0 9930.6 10080.5 10095.5 10288.4 10312.5 10794.2 10849.8 11056.5 11125.6 11230.2 10087.2 10162.3 10839.2 10931.8 11119.7 11049.3 11290.9 11511.2 11555.0 11896.6 10726.5 11115.4 11120.9 11458.7 11458.8 8370.8 8622.4 8758.3 8907.2 8954.2 7888.6 7905.9 7990.0 8351.7 8587.5 06:08:39 INFO - PROCESS | 3478 | -------- Summary: end -------- 06:08:39 INFO - PROCESS | 3478 | 06:08:40 INFO - TEST-INFO | 3478: exit 0 06:08:40 INFO - TEST-OK | dromaeo_css | took 1121323ms 06:08:40 INFO - TEST-START | kraken 06:08:40 INFO - operating with platform_type : linux_ 06:08:40 INFO - Initialising browser for kraken test... 06:08:40 INFO - TEST-INFO | started process 3783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPBvAMz/profile http://localhost:59822/getInfo.html) 06:08:44 INFO - PROCESS | 3783 | __metrics Screen width/height:1600/1200 06:08:44 INFO - PROCESS | 3783 | colorDepth:24 06:08:44 INFO - PROCESS | 3783 | Browser inner width/height: 1024/697 06:08:44 INFO - PROCESS | 3783 | __metrics 06:08:45 INFO - PROCESS | 3783 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:08:45 INFO - PROCESS | 3783 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:08:46 INFO - PROCESS | 3783 | console.error: PushService: 06:08:46 INFO - PROCESS | 3783 | stateChangeProcessEnqueue: Error transitioning state 06:08:46 INFO - PROCESS | 3783 | UnknownError 06:08:46 INFO - TEST-INFO | 3783: exit 0 06:08:46 INFO - Browser initialized. 06:08:46 INFO - Running cycle 1/1 for kraken test... 06:08:46 INFO - TEST-INFO | started process 3868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPBvAMz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:58 INFO - PROCESS | 3868 | RSS: Main: 173182976 06:08:58 INFO - PROCESS | 3868 | 06:09:01 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59822/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:02 INFO - PROCESS | 3868 | RSS: Main: 229969920 06:09:02 INFO - PROCESS | 3868 | 06:09:05 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59822/tests/kraken/driver.html?testName=audio-dft) 06:09:05 INFO - PROCESS | 3868 | RSS: Main: 217251840 06:09:05 INFO - PROCESS | 3868 | 06:09:08 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59822/tests/kraken/driver.html?testName=audio-fft) 06:09:09 INFO - PROCESS | 3868 | RSS: Main: 298364928 06:09:09 INFO - PROCESS | 3868 | 06:09:11 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59822/tests/kraken/driver.html?testName=audio-oscillator) 06:09:12 INFO - PROCESS | 3868 | RSS: Main: 209702912 06:09:12 INFO - PROCESS | 3868 | 06:09:14 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:14 INFO - PROCESS | 3868 | RSS: Main: 213323776 06:09:14 INFO - PROCESS | 3868 | 06:09:17 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59822/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:18 INFO - PROCESS | 3868 | RSS: Main: 252796928 06:09:18 INFO - PROCESS | 3868 | 06:09:21 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59822/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:22 INFO - PROCESS | 3868 | RSS: Main: 252297216 06:09:22 INFO - PROCESS | 3868 | 06:09:25 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59822/tests/kraken/driver.html?testName=json-parse-financial) 06:09:25 INFO - PROCESS | 3868 | RSS: Main: 251301888 06:09:25 INFO - PROCESS | 3868 | 06:09:27 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:27 INFO - PROCESS | 3868 | RSS: Main: 213372928 06:09:27 INFO - PROCESS | 3868 | 06:09:29 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59822/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:30 INFO - PROCESS | 3868 | RSS: Main: 220102656 06:09:30 INFO - PROCESS | 3868 | 06:09:32 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:32 INFO - PROCESS | 3868 | RSS: Main: 228966400 06:09:32 INFO - PROCESS | 3868 | 06:09:35 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:36 INFO - PROCESS | 3868 | RSS: Main: 238268416 06:09:36 INFO - PROCESS | 3868 | 06:09:38 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:39 INFO - PROCESS | 3868 | RSS: Main: 234647552 06:09:39 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:59822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59822/tests/kraken/driver.html?testName=ai-astar) 06:09:41 INFO - PROCESS | 3868 | RSS: Main: 287088640 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | __start_tp_report 06:09:41 INFO - PROCESS | 3868 | _x_x_mozilla_page_load 06:09:41 INFO - PROCESS | 3868 | _x_x_mozilla_page_load_details 06:09:41 INFO - PROCESS | 3868 | |i|pagename|runs| 06:09:41 INFO - PROCESS | 3868 | |0;ai-astar;104;113;112;111;112;112;113;114;114;113 06:09:41 INFO - PROCESS | 3868 | |1;audio-beat-detection;149;121;121;158;124;125;123;124;153;126 06:09:41 INFO - PROCESS | 3868 | |2;audio-dft;161;161;162;161;161;162;161;161;162;162 06:09:41 INFO - PROCESS | 3868 | |3;audio-fft;75;76;75;106;76;76;75;79;99;76 06:09:41 INFO - PROCESS | 3868 | |4;audio-oscillator;82;82;120;83;83;82;100;81;82;116 06:09:41 INFO - PROCESS | 3868 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;117 06:09:41 INFO - PROCESS | 3868 | |6;imaging-darkroom;147;147;146;146;146;147;146;146;146;147 06:09:41 INFO - PROCESS | 3868 | |7;imaging-desaturate;95;96;96;96;95;96;101;96;96;96 06:09:41 INFO - PROCESS | 3868 | |8;json-parse-financial;52;50;50;50;51;51;54;53;52;52 06:09:41 INFO - PROCESS | 3868 | |9;json-stringify-tinderbox;62;63;62;62;63;62;62;63;62;63 06:09:41 INFO - PROCESS | 3868 | |10;stanford-crypto-aes;80;81;88;79;79;78;79;80;79;79 06:09:41 INFO - PROCESS | 3868 | |11;stanford-crypto-ccm;144;134;128;133;129;141;129;141;178;129 06:09:41 INFO - PROCESS | 3868 | |12;stanford-crypto-pbkdf2;164;165;161;166;165;166;161;162;162;164 06:09:41 INFO - PROCESS | 3868 | |13;stanford-crypto-sha256-iterative;65;64;63;63;66;64;63;64;66;63 06:09:41 INFO - PROCESS | 3868 | __end_tp_report 06:09:41 INFO - PROCESS | 3868 | __start_cc_report 06:09:41 INFO - PROCESS | 3868 | _x_x_mozilla_cycle_collect,1725 06:09:41 INFO - PROCESS | 3868 | __end_cc_report 06:09:41 INFO - PROCESS | 3868 | __startTimestamp1479391781456__endTimestamp 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | ------- Summary: start ------- 06:09:41 INFO - PROCESS | 3868 | Number of tests: 14 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.90 (2.6%) stddev-sans-first:1.00 06:09:41 INFO - PROCESS | 3868 | Values: 104.0 113.0 112.0 111.0 112.0 112.0 113.0 114.0 114.0 113.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:125.50 stddev:14.68 (11.7%) stddev-sans-first:14.29 06:09:41 INFO - PROCESS | 3868 | Values: 149.0 121.0 121.0 158.0 124.0 125.0 123.0 124.0 153.0 126.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:09:41 INFO - PROCESS | 3868 | Values: 161.0 161.0 162.0 161.0 161.0 162.0 161.0 161.0 162.0 162.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.35 (14.9%) stddev-sans-first:11.81 06:09:41 INFO - PROCESS | 3868 | Values: 75.0 76.0 75.0 106.0 76.0 76.0 75.0 79.0 99.0 76.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:15.27 (18.6%) stddev-sans-first:15.84 06:09:41 INFO - PROCESS | 3868 | Values: 82.0 82.0 120.0 83.0 83.0 82.0 100.0 81.0 82.0 116.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:09:41 INFO - PROCESS | 3868 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:09:41 INFO - PROCESS | 3868 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.70 (1.8%) stddev-sans-first:1.74 06:09:41 INFO - PROCESS | 3868 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 101.0 96.0 96.0 96.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.35 (2.6%) stddev-sans-first:1.42 06:09:41 INFO - PROCESS | 3868 | Values: 52.0 50.0 50.0 50.0 51.0 51.0 54.0 53.0 52.0 52.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:09:41 INFO - PROCESS | 3868 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 63.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:2.86 (3.6%) stddev-sans-first:3.03 06:09:41 INFO - PROCESS | 3868 | Values: 80.0 81.0 88.0 79.0 79.0 78.0 79.0 80.0 79.0 79.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:137.50 stddev:15.03 (10.9%) stddev-sans-first:15.82 06:09:41 INFO - PROCESS | 3868 | Values: 144.0 134.0 128.0 133.0 129.0 141.0 129.0 141.0 178.0 129.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.50 stddev:1.96 (1.2%) stddev-sans-first:2.07 06:09:41 INFO - PROCESS | 3868 | Values: 164.0 165.0 161.0 166.0 165.0 166.0 161.0 162.0 162.0 164.0 06:09:41 INFO - PROCESS | 3868 | 06:09:41 INFO - PROCESS | 3868 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.20 (1.9%) stddev-sans-first:1.22 06:09:41 INFO - PROCESS | 3868 | Values: 65.0 64.0 63.0 63.0 66.0 64.0 63.0 64.0 66.0 63.0 06:09:41 INFO - PROCESS | 3868 | -------- Summary: end -------- 06:09:41 INFO - PROCESS | 3868 | 06:09:42 INFO - TEST-INFO | 3868: exit 0 06:09:42 INFO - TEST-OK | kraken | took 62035ms 06:09:42 INFO - SUITE-END | took 1183s 06:09:43 INFO - Completed test suite (00:19:43) 06:09:43 INFO - javascript benchmark 06:09:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3009.0371081253993, 3053.7098975597337, 3080.5533197686336, 3092.9072127836157, 3095.752339812815, 5207.401148867882, 5248.973755131219, 5252.6848389096685, 5279.683219006863, 5334.466553344669, 5280.1815718563585, 5357.303550538434, 5358.169483730028, 5359.866003349918, 5434.592405569579, 4776.450708168553, 4776.522347765231, 4808.230683090706, 4844.636652251078, 4857.562819346258, 4886.877828054292, 4908.0, 4983.700977941335, 4994.950050499503, 5032.6477146599755, 4894.755262236874, 4901.044296362211, 4947.332110165117, 4954.925676114861, 4980.800767969277, 4728.4562275338085, 4755.643326750507, 4761.547652972962, 4795.448523419816, 4825.9034819303415, 4777.140114779339, 4778.044391121754, 4799.256115302133, 4801.1117943180625, 4804.975975120137, 5206.297149884755, 5243.370795504526, 5246.658967167122, 5262.394824595182, 5274.077036518633, 5551.694656793875, 5570.721463926828, 5574.247476590649, 5584.0507113790345, 5605.579581531401, 5599.356074051496, 5662.971685141589, 5663.9716801415725, 5669.0, 5674.0, 5242.325971762157, 5267.815626453055, 5321.388040375329, 5376.166694162372, 5383.623146379755, 5742.08126699726, 5758.0, 5765.711714414262, 5770.538356931435, 5770.567207459458, 5430.972845135828, 5526.281583394133, 5548.750306236229, 5553.444655534414, 5553.861153471114, 5521.061419558604, 5599.636023658449, 5600.6919619420505, 5661.801836935688, 5665.405132461115, 5675.091985282335, 5682.431756824284, 5684.801031963944, 5687.772489100473, 5729.713514324267, 5683.062294721407, 5695.800646977419, 5696.031674615326, 5708.828735137952, 5732.914006289909, 4251.9787401062795, 4304.935425968613, 4315.762633055212, 4347.717398369159, 4348.195583817004, 3836.501254836853, 3896.59085795993, 3897.2595206910596, 3913.295606790748, 3916.784576848244, 5392.676439413648, 5398.757055932492, 5408.378036525771, 5410.891782164414, 5413.188021796684, 5726.484616384545, 5737.741801618937, 5739.397363276796, 5744.626599271034, 5770.365259821417, 5286.60350473716, 5287.576993840484, 5346.358436987586, 5403.972980135074, 5414.458554144633, 4721.834735784231, 4790.952090479121, 4797.976010119927, 4800.159972004885, 4808.567228949341, 5901.0558310670085, 5913.497352724895, 5914.378990206053, 5914.852128696731, 5916.497097746654, 5706.80026199081, 5722.484976352148, 5730.942690573041, 5734.5125664319, 5736.282964629421, 5898.056310990221, 5914.024186009432, 5915.58590898633, 5916.230889984275, 5923.052311630118, 5636.2954630671165, 5651.88696226065, 5653.067243904709, 5654.264945557051, 5656.915146272727, 5681.914771278517, 5685.971570142123, 5692.117721753135, 5750.856228594319, 5763.0, 5625.09998400254, 5633.802816901389, 5648.096304591246, 5657.405972373006, 5658.717064146858, 5403.4326395727885, 5473.890522189614, 5474.3704473986, 5621.578381621476, 5629.408912064175, 5420.83737487876, 5531.529819965187, 5537.390887002346, 5537.944620553904, 5546.4453554644215, 5565.6104072714525, 5591.748371323381, 5593.496585307342, 5599.272094627672, 5601.439856014366, 5420.593455490933, 5432.538234249975, 5477.507024367666, 5491.807786727445, 5567.331920169606], "value": 5237.766468204988, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.4036922708065, 607.1924340626965, 619.1053927075378, 630.1807650054925, 646.789793317172, 26911.865440672795, 33638.66361336386, 34394.484082738745, 34460.1384965376, 36347.63652363482, 34480.1379965501, 34770.8261458693, 34792.65207347926, 34903.82548087256, 34906.0, 6772.7629532966475, 6922.996165556016, 6931.272216417279, 6934.722611095575, 6935.687894044755, 5971.790987315445, 6102.5117990560875, 7009.929900700979, 7207.603581802999, 7209.531380460253, 7195.316444937749, 7242.529235599669, 7243.529170603921, 7243.927560724404, 7244.891326630105, 7169.139703235593, 7222.855542889165, 7230.421566274686, 7230.638468076628, 7234.529755565898, 7253.0, 7299.854002919912, 7312.744053958139, 7315.9634201829185, 7316.414686825041, 32219.6778032219, 32532.837335813405, 32538.511922321184, 32539.6746032539, 32540.837295813606, 3331.4669652855428, 3360.9159771005675, 3512.7892326460496, 3718.3307004739136, 4028.939565906514, 23072.653910191362, 23354.0, 23851.284461466184, 23896.0, 24134.879325603437, 3604.189057462076, 3643.9271214575824, 3649.4708267301357, 3712.684421824148, 3752.418375151856, 340012.0, 340712.0, 341017.0, 342464.0, 342952.8423094424, 34086.48870266948, 34949.30101398009, 58150.709246454346, 58537.1706234348, 58632.120518191405, 36574.085647859014, 36960.0, 37012.0, 37014.81492592573, 37033.0, 14256.287185640676, 14306.57080287593, 14376.568702938928, 14376.928115359357, 14421.20683362404, 10982.121430285717, 11263.774724505463, 11894.0, 12001.87998120025, 12013.939930300292, 8195.34437245019, 8244.793880153044, 8252.711155109542, 8526.701565445179, 8529.872051919227, 3231.579894613732, 3260.3153337799326, 3271.7915407100113, 3280.048785852076, 3289.358575077885, 945.3618807305041, 1000.1898462245605, 1009.2178561614661, 1082.3451811653993, 1089.5600428254736, 29335.706642933725, 31276.687233127832, 31488.685113148575, 31645.683543164734, 32117.839410802797, 1094.2067001423904, 1110.655696734015, 1129.7062763681338, 1157.3518829455531, 1165.6328256599145, 15531.611709707347, 16380.426685066204, 16388.590285242964, 16428.835711642732, 16662.750058749127, 746706.0, 760706.0, 761733.0, 762416.0, 762844.0, 52498.73750631222, 53252.73373633107, 53269.46730532645, 53330.73334633379, 53350.73324633352, 1304.4064950447714, 1338.056670047614, 1338.2840180503579, 1344.9125806822526, 1357.762391581489, 29510.262243444085, 31008.68991310058, 31246.531302030944, 31299.84350078235, 31526.369472610877, 50623.24065138952, 51131.48868511267, 51164.0, 51169.0, 51244.487555123975, 442237.0, 443383.0, 447633.0, 448352.0, 450251.0, 27101.322466938484, 27296.0, 27349.589756153277, 27648.861755691094, 27743.86128069347, 42371.364429532965, 42765.78617107019, 43212.35181472218, 43251.134977300906, 43269.0, 36001.63998359983, 36658.8167059163, 36996.745374282305, 37510.43734343933, 37717.62282377141, 36027.81986090053, 37274.627253727114, 37394.813025935786, 37533.2493350126, 37600.62399375971, 37830.0, 38299.23401532009, 38847.863367515056, 38874.0, 39201.607983920934, 32578.51132232971, 34092.14769630779, 34714.65285347114, 34796.30407391889, 34947.825260873535, 26757.0, 27096.79995607524, 27227.72772272252, 27255.59116613292, 27258.454830902876], "value": 17409.219739245404, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.11188253132246, 373.21438372226464, 381.1823638295855, 386.89747216987496, 408.1327179743046, 12295.569655062063, 12980.415881285342, 13529.323533823293, 15804.051756894594, 16209.108499032549, 17061.658766824658, 17759.378421755242, 18097.0, 18369.173387197574, 18587.721184182214, 4869.220924652056, 5184.144616138352, 5185.144451165553, 5189.169732842746, 5191.273221748958, 3551.68034876861, 3656.3235801376695, 5061.848144555669, 5157.355330583677, 5171.534561889429, 3713.2016616427463, 5082.466341034194, 5102.821401250957, 5146.099432599281, 5149.716765577892, 4912.214045752698, 5091.956148989449, 5141.948580514184, 5144.0740666679985, 5150.072986862363, 4552.521985191574, 4581.358609794632, 4584.174848527264, 4584.88537786558, 4585.3122031695175, 15967.0, 16082.276297566637, 17799.555011124827, 19286.807131928643, 19435.514112147168, 2293.6788849561076, 2360.468894498741, 2376.040760531875, 2471.8146139039645, 2941.529355303141, 12237.449314780857, 12482.563110291096, 12774.61676149717, 13091.607251782367, 13300.201987880759, 1699.9150042497827, 1712.725963845791, 1714.5370749897584, 1743.9651206975789, 1778.644271145763, 80087.5995620024, 82253.58873205596, 82813.58593207055, 84017.57991210066, 85482.0, 10049.397036177852, 10097.798044039078, 10315.74210644725, 10403.479826008821, 10687.30532515384, 14780.187089709954, 14796.408143674133, 14815.555533334018, 14817.925910370379, 14829.62925926839, 7589.772306830693, 7874.56689882062, 7885.369170466349, 8135.471194372347, 8155.551444670481, 7511.51175173612, 7553.660085296175, 7620.809479762939, 7814.101378341564, 7901.091374492007, 6373.52198585108, 6459.870802584016, 6482.319356467598, 6492.67536623167, 6660.933390666129, 1794.883332583378, 1828.1955939386894, 1885.8397036252072, 1887.9528011799541, 1898.2881419467699, 1000.1798525209258, 1021.6373187518473, 1063.707480442869, 1066.2429674930886, 1091.8362245663213, 19593.608127837364, 20010.499737506678, 20106.396808095487, 20198.39404817858, 20549.76701397921, 982.7543114221445, 1011.3577878047493, 1013.7566983923805, 1015.21320976244, 1027.9691609251734, 10945.781084378268, 11270.774584508265, 11323.830142547868, 11417.771644567061, 11422.885771142182, 350369.0, 352138.0, 352237.0, 456808.0, 487820.0, 100777.0, 101377.49311253396, 103075.0, 103520.48239758753, 106162.0, 965.1554889471712, 984.5028260728286, 1030.5620111452602, 1034.8447732840134, 1038.1694644284694, 16600.916995415428, 16646.751493637785, 16711.0, 17216.569585760455, 17918.104094795468, 41332.79333603313, 42408.0, 42671.0, 43193.35209971916, 44834.0, 61171.694141529006, 62137.378626214966, 63136.36863631305, 63431.6828415855, 63499.0, 8353.624086915981, 8377.95811020941, 8519.148085191431, 8543.40196186261, 8772.605232764668, 11030.950435458388, 12442.440090195782, 12721.93639031799, 13038.869611303766, 13479.595612131652, 10569.735756606146, 10793.67618971432, 10861.45692715377, 11572.6528204154, 11602.187846850977, 10871.945640271748, 11229.438528073728, 11256.324620522795, 11284.661460156209, 11441.313521188755, 11219.587788625484, 11440.656780296604, 11593.246438981776, 11646.534138634699, 11919.106067045179, 7746.264104910025, 7889.6449659766595, 7909.960450197942, 8329.916700832913, 8599.183077607617, 8564.527191578782, 11307.0, 11430.885691142983, 11864.644060678194, 11932.747061558759], "value": 8889.975089732365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.5070048031516, 1388.4931999820064, 1405.6977749783798, 1477.9630509237268, 1663.0603708904475, 6444.935550644492, 6932.480063995202, 7163.89254161188, 7173.246809085049, 7316.231795661459, 7205.495615306918, 7277.781666550012, 7280.089988751406, 7281.817954551138, 7286.089238845145, 2001.149511457632, 2036.745406824147, 2041.2753472517265, 2042.0402410866868, 2043.019350711652, 2014.4661664658877, 2032.5325175209637, 2040.6122836660986, 2085.4786303424144, 2086.6139764143604, 1999.2502811445709, 2000.6998950157447, 2025.2202901882808, 2026.4224695961655, 2027.1688607670858, 1983.226541648758, 1995.4213278149464, 2000.2898970865278, 2005.3081686818098, 2009.9095540700703, 1919.1555715485142, 1933.4296382567177, 1996.440996520962, 2001.9299324523718, 2003.3989803059023, 6945.0, 7194.424446044304, 7204.567725936408, 7256.963715181443, 7259.056322678018, 4817.927731084036, 4951.727654978975, 4957.950420495785, 4959.677620954626, 4967.528084831935, 3097.148284221857, 3252.349530093991, 3261.96738032619, 3330.6003279606603, 3338.5159151923076, 1033.7415646088477, 1043.2957753516346, 1066.3335415365398, 1084.3385534823751, 1084.4631907205905, 10004.549795259158, 10017.298789084767, 10095.343802652804, 10104.292699511037, 10121.392716436963, 3897.785621790772, 4112.856050038235, 4174.812133454002, 4188.183304255702, 4254.42565253693, 8169.183081691902, 8169.346452283803, 8176.509409435453, 8199.631016604268, 8202.876956845652, 4832.130216561053, 4833.419989601271, 4833.9033219335415, 4836.951630483721, 4837.32277481153, 3815.198808250243, 3971.245463361952, 4146.481689788777, 4542.0, 4542.931856022163, 3457.0, 3480.216951185963, 3588.766730162531, 3596.9640303597153, 3603.2253065591026, 1126.245415571569, 1137.0676045642658, 1142.491591241906, 1143.2740209966564, 1165.056304393444, 804.8651401523823, 896.6547879066476, 899.6086702284528, 924.4591913730409, 925.2551695884742, 5188.81839135636, 5238.7904483820985, 5393.568514518907, 5462.590305727086, 5469.234307196995, 450.9774511274423, 463.2657238277368, 464.40092280957185, 466.64534953435634, 466.8109415686652, 3681.9079523011605, 3750.1749615084636, 3754.455603937414, 3771.113788259757, 3880.3791393376923, 8804.427712198814, 9034.2320902724, 9130.817383652422, 9134.314926380415, 9144.131307525775, 8477.152284771473, 9091.909080909107, 9104.271658267322, 9104.362694611445, 9105.089491050841, 6752.864942701119, 7005.439564834801, 7057.964710176417, 7079.327463890922, 7094.893576596355, 4996.550310472075, 5094.974525127351, 5111.207762796624, 5140.948590514196, 5365.704886231295, 8394.454360466794, 8522.27560657351, 8523.0, 8585.141485851615, 8593.785155371166, 7708.8458230836195, 8015.318697910509, 8347.624356903832, 8489.87265191035, 8536.189062039097, 5945.672987985529, 6403.615783053032, 6545.37818907203, 6635.8009259722285, 6641.435477984425, 6883.931160688529, 7169.749058782918, 7240.420766338786, 7318.96340518294, 7329.670164842488, 6289.182406287154, 6327.873442531216, 6356.364363563792, 6417.8716425672155, 6647.534672572873, 6389.680515974275, 6513.348665133449, 6585.80242592723, 6655.267920528641, 6690.899636505359, 6056.9697151513965, 6137.815865524041, 6179.721912513858, 6182.629042257479, 6188.783392581238, 4512.774361281989, 4612.354270402079, 4631.216981462094, 4664.673472856867, 4726.243800991825, 4699.859004229878, 4714.38712967312, 4773.403324584427, 4795.544423279783, 4859.854204373874], "value": 3974.641424612887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.96730326967304, 331.2084118955696, 333.9515770213319, 339.14704518136875, 339.28749625785855, 5220.895582088356, 5315.202719592063, 5318.175682769172, 5322.414534401218, 5334.413214546396, 5229.241759944805, 5235.450277720842, 5255.76349064292, 5256.94861027794, 5269.314989051428, 3887.2225554888996, 4001.539822920358, 4061.878143655695, 4069.0671930832914, 4123.257813593552, 4123.464069597191, 4126.504819421659, 4154.400555786014, 4156.8129434175535, 4164.541900390955, 4070.4911886014247, 4081.1837632473475, 4100.487439070116, 4111.075008123178, 4142.440770495989, 3743.8315275812383, 3881.9029524261837, 3967.7817720025387, 4154.875353739378, 4182.545588947761, 3686.944695829565, 3699.0012696572044, 3699.7780133192095, 3701.3152566775234, 3701.7593856399517, 5135.279681306767, 5135.356685860526, 5154.871128221787, 5161.251618515332, 5187.559057480119, 4674.7093923977345, 4699.929501057487, 4752.7861246244, 4761.190597598416, 4763.809447622091, 5531.363893152299, 5532.944670553283, 5535.723213839292, 5540.50135487804, 5540.750666220029, 4066.3900414937702, 4071.8982025449304, 4074.6536544393466, 4081.4694089768436, 4084.305668036441, 5481.232627432163, 5736.2256095427, 5737.885242295172, 5787.797427090074, 5788.739506722208, 4066.3087275163293, 4072.2466343726505, 4073.857414990461, 4085.264652362544, 4085.89785255371, 4071.816768245436, 4085.89785255371, 4094.3653733671326, 4136.710430269913, 4142.192272506893, 4515.9774201128785, 4664.976675116603, 4665.790039448233, 4674.288912430782, 4683.367745354333, 5530.50676317392, 5553.723303251101, 5560.471755183251, 5562.3047119110115, 5563.833085007456, 1367.7196174784146, 1379.048456564967, 1382.5921353200629, 1384.2732565403244, 1387.7502049631164, 889.3241136735998, 909.7680091576738, 944.2964991081551, 944.5702205496483, 952.72810797586, 5314.229436731653, 5329.467053294639, 5341.65279256847, 5352.678839269656, 5357.651752636066, 5665.232620307532, 5689.2319536862, 5695.829125126253, 5709.68596727184, 5716.828050249689, 5131.974340128276, 5305.363356397257, 5339.145736682112, 5343.62594618373, 5368.194770784336, 2871.8420486873424, 2881.7982741208334, 2885.701434354507, 2894.522403803349, 2895.6959519250177, 5630.354957160359, 5647.989927151768, 5657.688827114548, 5660.15097735343, 5663.235463212496, 5307.761150748225, 5509.862253443615, 5567.8886422272135, 5578.414266501959, 5611.859703507445, 5589.664620122806, 5603.719814009365, 5614.943850561442, 5622.987862184846, 5675.489205971482, 5260.947390526198, 5453.0, 5454.154606036071, 5471.398146203994, 5492.253873063468, 5394.543473262275, 5396.865078373072, 5400.378956419905, 5406.621536492565, 5427.755750991294, 5537.36320323168, 5571.629164355669, 5579.693116878449, 5605.32736071674, 5607.80372686954, 3776.2825063237897, 3905.941410878896, 3907.57016728154, 3921.0, 3928.2929072767174, 5419.96481970098, 5439.891202175855, 5445.618806683494, 5461.644993075437, 5465.9726701366235, 5336.279602253646, 5345.33183352081, 5448.256557901434, 5460.290162278879, 5474.698891561003, 5074.594032477319, 5282.260483532232, 5327.627066105335, 5337.386200586827, 5351.678899266057, 5253.632245742914, 5314.362276526842, 5326.789382406258, 5331.3868905076415, 5355.651882627617, 5394.9730251350065, 5431.646942948696, 5552.222688823487, 5567.498925096761, 5596.41237670055, 5374.462553744751, 5407.675539467645, 5409.350877894678, 5410.404855465974, 5454.154606036071], "value": 4168.6058362358435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.5272967112036, 729.5258082246539, 764.0029761161685, 778.3073064972174, 784.2706283156662, 11936.522539098436, 12611.684707882308, 12642.36788160593, 12673.0, 12748.681282967931, 12909.612711618667, 13128.671783205426, 13153.145045572031, 13160.27618480983, 13162.07865449419, 624.9656268905209, 642.7364780440021, 726.2628432141381, 736.8673638745024, 748.8127968007998, 740.5038624121825, 745.5265906149607, 753.1338960195791, 753.1827966656184, 753.3333000294751, 782.0654318089885, 783.2011348424631, 786.7364432914952, 786.8072322281049, 787.6731156570016, 641.8459569703284, 662.6322391072953, 781.9921800782005, 782.2763943352405, 782.3076577229136, 554.7226386806597, 570.6490508337342, 572.364675210516, 572.6363759013016, 572.7107810555643, 11147.275427097295, 11189.720256993558, 11196.10431165513, 11209.943950280196, 11210.327380357205, 10545.630902918438, 10592.364458132537, 11175.776484470265, 11281.0, 11572.074234061254, 9615.807683846353, 9643.180329671986, 9898.406095634286, 9898.653547125889, 9911.90088099117, 3041.1788817019283, 3054.328047829496, 3069.478188707925, 3075.861586228625, 3137.043201823443, 57454.0, 58495.0, 61907.7852154394, 62185.689071554356, 64133.3586664132, 8312.0, 8371.95814020926, 8378.916210837813, 8421.621027053798, 8593.871091933626, 15452.5364239073, 15458.304376303093, 15470.303836327392, 15552.455664051704, 15554.9222253888, 7778.611069446505, 7849.725259615886, 7868.0, 7972.720954766555, 8108.878366824502, 4398.582134697199, 4425.690201685916, 4507.278835386388, 4563.680542362003, 4568.954310456919, 3232.2242661761006, 3321.0, 3321.9833900830827, 3322.5182348559806, 3330.816805075696, 561.8511094559944, 562.2858969109209, 577.0363492966756, 582.860113572748, 589.4547543522225, 587.0284678856499, 596.1951365656329, 653.2362867321913, 656.7799787071384, 664.6391217268767, 8161.918380816234, 8517.531535765593, 8666.86999695005, 8671.21959023691, 8859.025507194203, 549.7388740348302, 586.9031609784423, 627.4415769964735, 637.2452008707753, 665.2582370656683, 4188.308929026737, 4214.178235244098, 4319.546447623017, 4429.269170586882, 4541.72749635023, 51004.0, 51854.22218666723, 51872.22191667128, 65161.0, 74101.0, 69695.0, 71970.64014679893, 72380.91428628574, 73411.2658873415, 74275.0, 60238.0, 66217.66891165513, 66703.33296666971, 66830.0, 68094.65952670304, 7400.370968467741, 7829.177936316605, 7911.802204944692, 8008.919910801051, 8340.0, 43388.78305608452, 43647.56352436435, 44780.77609611931, 45162.32256516089, 46335.768321158175, 57148.428515715976, 62278.68860655668, 62655.37344626495, 62837.37162628315, 64709.0, 9930.602775889172, 10080.495975201356, 10095.545700443645, 10288.382697038202, 10312.535935882754, 10794.190435717195, 10849.783004340026, 11056.502457389597, 11125.610603628835, 11230.21388502797, 10087.193024557871, 10162.288639795144, 10839.187060970302, 10931.781364372828, 11119.666410007712, 11049.28179668319, 11290.943545282222, 11511.19421640477, 11555.0, 11896.583619573274, 10726.463676815973, 11115.444227788417, 11120.888791111985, 11458.656240312805, 11458.82811757841, 8370.790730231793, 8622.439541429787, 8758.343124265579, 8907.198352148338, 8954.194122529003, 7888.566128862968, 7905.881411778713, 7990.0, 8351.707690231056, 8587.527685977082], "value": 6230.719494731232, "unit": "score"}], "name": "dromaeo_css", "value": 6613.780920818846, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 111.0, 112.0, 112.0, 113.0, 114.0, 114.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 121.0, 158.0, 124.0, 125.0, 123.0, 124.0, 153.0, 126.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 106.0, 76.0, 76.0, 75.0, 79.0, 99.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 120.0, 83.0, 83.0, 82.0, 100.0, 81.0, 82.0, 116.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 101.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 50.0, 51.0, 51.0, 54.0, 53.0, 52.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 88.0, 79.0, 79.0, 78.0, 79.0, 80.0, 79.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 134.0, 128.0, 133.0, 129.0, 141.0, 129.0, 141.0, 178.0, 129.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 161.0, 166.0, 165.0, 166.0, 161.0, 162.0, 162.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 63.0, 66.0, 64.0, 63.0, 64.0, 66.0, 63.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1498.1999999999998, "alertThreshold": 2.0}]} 06:09:43 INFO - Return code: 0 06:09:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:09:43 INFO - # TBPL SUCCESS # 06:09:43 INFO - Running post-action listener: _resource_record_post_action 06:09:43 INFO - [mozharness: 2016-11-17 14:09:43.251045Z] Finished run-tests step (success) 06:09:43 INFO - Running post-run listener: _resource_record_post_run 06:09:43 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8085504; Write bytes: 411136000; Read time: 2944; Write time: 452644 06:09:43 INFO - TinderboxPrint: CPU usage
13.1% 06:09:43 INFO - TinderboxPrint: I/O read bytes / time
8,085,504 / 2,944 06:09:43 INFO - TinderboxPrint: I/O write bytes / time
411,136,000 / 452,644 06:09:43 INFO - TinderboxPrint: CPU idle
8,323.7 (86.9%) 06:09:43 INFO - TinderboxPrint: CPU user
1,205.9 (12.6%) 06:09:43 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 11112448; Read time: 0; Write time: 3360 06:09:43 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5914624; Write bytes: 341618688; Read time: 2264; Write time: 381160 06:09:43 INFO - Running post-run listener: _upload_blobber_files 06:09:43 INFO - Blob upload gear active. 06:09:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:44 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:09:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:45 INFO - (blobuploader) - INFO - Done attempting. 06:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:46 INFO - (blobuploader) - INFO - Done attempting. 06:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:50 INFO - (blobuploader) - INFO - Done attempting. 06:09:50 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:50 INFO - Return code: 0 06:09:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c336f1d735bc7bde2622efd34708b2d24f879b461af99d02cf4bb5953727b8820da960531c921f11ea28f64ae994bceefc09d540f23ef26f3bd070a2b1896ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ce9f3c0aacf822fdb286569e64297b766cccede8f0563d01d0061e37669334a38b9d3ce978292be53eba587bb346e3213d9dbfcf422c5c62c67f47931dd2a7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fe05d2dbc590311ce4761cdee796d8776769953e96add5828bf61bab961a4415f026d463e2611f37ec244e161ee9106f0aa97aaee2d88a224119d3a1fcbef60"} 06:09:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:50 INFO - Contents: 06:09:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c336f1d735bc7bde2622efd34708b2d24f879b461af99d02cf4bb5953727b8820da960531c921f11ea28f64ae994bceefc09d540f23ef26f3bd070a2b1896ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ce9f3c0aacf822fdb286569e64297b766cccede8f0563d01d0061e37669334a38b9d3ce978292be53eba587bb346e3213d9dbfcf422c5c62c67f47931dd2a7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fe05d2dbc590311ce4761cdee796d8776769953e96add5828bf61bab961a4415f026d463e2611f37ec244e161ee9106f0aa97aaee2d88a224119d3a1fcbef60"} 06:09:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:50 INFO - Copying logs to upload dir... 06:09:50 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.807556 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-17 06:09:50.041273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 06:09:50.044479) ========= 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=6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c336f1d735bc7bde2622efd34708b2d24f879b461af99d02cf4bb5953727b8820da960531c921f11ea28f64ae994bceefc09d540f23ef26f3bd070a2b1896ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ce9f3c0aacf822fdb286569e64297b766cccede8f0563d01d0061e37669334a38b9d3ce978292be53eba587bb346e3213d9dbfcf422c5c62c67f47931dd2a7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fe05d2dbc590311ce4761cdee796d8776769953e96add5828bf61bab961a4415f026d463e2611f37ec244e161ee9106f0aa97aaee2d88a224119d3a1fcbef60"} build_url:https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/Sc2_vRnSTOKyquVZS2F2WQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c336f1d735bc7bde2622efd34708b2d24f879b461af99d02cf4bb5953727b8820da960531c921f11ea28f64ae994bceefc09d540f23ef26f3bd070a2b1896ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ce9f3c0aacf822fdb286569e64297b766cccede8f0563d01d0061e37669334a38b9d3ce978292be53eba587bb346e3213d9dbfcf422c5c62c67f47931dd2a7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fe05d2dbc590311ce4761cdee796d8776769953e96add5828bf61bab961a4415f026d463e2611f37ec244e161ee9106f0aa97aaee2d88a224119d3a1fcbef60"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 06:09:50.072528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:09:50.073212) ========= 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=6d15e502d8e29d5d2676d664000001c3-1479383055.537097-158671959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004313 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:09:50.158549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 06:09:50.159339) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 06:09:50.159994) ========= ========= Total master_lag: 0.19 =========