builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1480008049.27 results: success (0) buildid: 20161124080519 builduid: accecb9c9ed24f3cb917dc0bb50cdc70 revision: bad312aefb42982f492ad2cf36f4c6c3d698f4f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:49.266710) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:49.267155) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:49.267421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:49.281987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:49.282259) ========= 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=0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 09:20:49-- 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% 104M=0s 2016-11-24 09:20:49 (104 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082731 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:49.378447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:49.378723) ========= 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=0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018355 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:49.427391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:49.427701) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bad312aefb42982f492ad2cf36f4c6c3d698f4f7 --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 bad312aefb42982f492ad2cf36f4c6c3d698f4f7 --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=0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 09:20:50,076 truncating revision to first 12 chars 2016-11-24 09:20:50,077 Setting DEBUG logging. 2016-11-24 09:20:50,077 attempt 1/10 2016-11-24 09:20:50,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bad312aefb42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 09:20:50,386 unpacking tar archive at: mozilla-central-bad312aefb42/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691735 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:50.134696) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:50.135227) ========= script_repo_revision: bad312aefb42982f492ad2cf36f4c6c3d698f4f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:50.135848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:50.136321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 09:20:50.147556) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-24 09:20:50.147859) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:20:50 INFO - MultiFileLogger online at 20161124 09:20:50 in /builds/slave/test 09:20:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:20:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:50 INFO - {'append_to_log': False, 09:20:50 INFO - 'base_work_dir': '/builds/slave/test', 09:20:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:20:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:50 INFO - 'branch': 'Firefox-Non-PGO', 09:20:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:50 INFO - 'config_files': ('talos/linux_config.py',), 09:20:50 INFO - 'default_actions': ('clobber', 09:20:50 INFO - 'read-buildbot-config', 09:20:50 INFO - 'download-and-extract', 09:20:50 INFO - 'populate-webroot', 09:20:50 INFO - 'create-virtualenv', 09:20:50 INFO - 'install', 09:20:50 INFO - 'run-tests'), 09:20:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:50 INFO - 'download_minidump_stackwalk': True, 09:20:50 INFO - 'download_symbols': 'ondemand', 09:20:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:50 INFO - 'installer_path': 'installer.exe', 09:20:50 INFO - 'log_level': 'info', 09:20:50 INFO - 'log_name': 'talos', 09:20:50 INFO - 'log_to_console': True, 09:20:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:20:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:20:50 INFO - 'opt_config_files': (), 09:20:50 INFO - 'pip_index': False, 09:20:50 INFO - 'sps_profile': False, 09:20:50 INFO - 'sps_profile_interval': 0, 09:20:50 INFO - 'suite': 'dromaeojs', 09:20:50 INFO - 'system_bits': '32', 09:20:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:50 INFO - 'title': 'talos-linux64-ix-017', 09:20:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:50 INFO - 'use_talos_json': True, 09:20:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:50 INFO - 'work_dir': 'build'} 09:20:50 INFO - [mozharness: 2016-11-24 17:20:50.898150Z] Running clobber step. 09:20:50 INFO - Running pre-action listener: _resource_record_pre_action 09:20:50 INFO - Running main action method: clobber 09:20:50 INFO - rmtree: /builds/slave/test/build 09:20:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:51 INFO - Running post-action listener: _resource_record_post_action 09:20:51 INFO - [mozharness: 2016-11-24 17:20:51.889488Z] Finished clobber step (success) 09:20:51 INFO - [mozharness: 2016-11-24 17:20:51.889586Z] Running read-buildbot-config step. 09:20:51 INFO - Running pre-action listener: _resource_record_pre_action 09:20:51 INFO - Running main action method: read_buildbot_config 09:20:51 INFO - Using buildbot properties: 09:20:51 INFO - { 09:20:51 INFO - "project": "", 09:20:51 INFO - "product": "firefox", 09:20:51 INFO - "script_repo_revision": "production", 09:20:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:20:51 INFO - "repository": "", 09:20:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:20:51 INFO - "buildid": "20161124080519", 09:20:51 INFO - "pgo_build": "False", 09:20:51 INFO - "basedir": "/builds/slave/test", 09:20:51 INFO - "buildnumber": 309, 09:20:51 INFO - "slavename": "talos-linux64-ix-017", 09:20:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:20:51 INFO - "platform": "ubuntu64_hw", 09:20:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:20:51 INFO - "branch": "mozilla-central", 09:20:51 INFO - "repo_path": "mozilla-central", 09:20:51 INFO - "revision": "bad312aefb42982f492ad2cf36f4c6c3d698f4f7", 09:20:51 INFO - "stage_platform": "linux64", 09:20:51 INFO - "builduid": "accecb9c9ed24f3cb917dc0bb50cdc70", 09:20:51 INFO - "slavebuilddir": "test" 09:20:51 INFO - } 09:20:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:20:51 INFO - Running post-action listener: _resource_record_post_action 09:20:51 INFO - [mozharness: 2016-11-24 17:20:51.892059Z] Finished read-buildbot-config step (success) 09:20:51 INFO - [mozharness: 2016-11-24 17:20:51.892148Z] Running download-and-extract step. 09:20:51 INFO - Running pre-action listener: _resource_record_pre_action 09:20:51 INFO - Running main action method: download_and_extract 09:20:51 INFO - mkdir: /builds/slave/test/build/tests 09:20:51 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')]} 09:20:51 INFO - trying https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:20:51 INFO - Downloading https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/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 09:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/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 09:20:52 INFO - Downloaded 1361 bytes. 09:20:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:20:52 INFO - Using the following test package requirements: 09:20:52 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:20:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:20:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:20:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:52 INFO - u'jsshell-linux-x86_64.zip'], 09:20:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:20:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:20:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:20:52 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:20:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:20:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:20:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:20:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:20:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:20:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:20:52 INFO - Fetch https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:20:53 INFO - Http code: 200 09:20:53 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 09:20:53 INFO - x-amz-cf-id: s53NsqbHmfK5FuAdJxm24bUevmIcRiz2gMaCi3mkn9D0AOsifVGSDA== 09:20:53 INFO - x-amz-version-id: tjJL4q79fzl1Xq.Gr4vP._PkiQi2HHuq 09:20:53 INFO - Expected file size: 20203516 09:20:53 INFO - Obtained file size: 20203516 09:20:57 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 09:20:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:20:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:20:57 INFO - Fetch https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:20:57 INFO - Http code: 200 09:20:57 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 09:20:57 INFO - x-amz-cf-id: -FwSrMKMJoCLJrcQd0LLlBgPCwD-EpnxC90vW4RHUHH6BubaBVd5tg== 09:20:57 INFO - x-amz-version-id: tjJL4q79fzl1Xq.Gr4vP._PkiQi2HHuq 09:20:58 INFO - Expected file size: 20203516 09:20:58 INFO - Obtained file size: 20203516 09:21:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:21:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:21:02 INFO - Fetch https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:21:03 INFO - Http code: 200 09:21:03 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 09:21:03 INFO - x-amz-cf-id: Fhb4TR6eBfFyuJGPJggJIMqL9RcOugU8_1HO2eym6gQs74qNIl_ufg== 09:21:03 INFO - x-amz-version-id: jLNG.zxJCBir8SbXBVW.tiSjMuX0MqxH 09:21:03 INFO - Expected file size: 14409749 09:21:03 INFO - Obtained file size: 14409749 09:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:03 INFO - trying https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:21:03 INFO - Downloading https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/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 09:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/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 09:21:04 INFO - Downloaded 55636159 bytes. 09:21:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:21:04 INFO - mkdir: /builds/slave/test/properties 09:21:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:04 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:04 INFO - Contents: 09:21:04 INFO - build_url:https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:21:05 INFO - Running post-action listener: _resource_record_post_action 09:21:05 INFO - Running post-action listener: set_extra_try_arguments 09:21:05 INFO - [mozharness: 2016-11-24 17:21:05.418485Z] Finished download-and-extract step (success) 09:21:05 INFO - [mozharness: 2016-11-24 17:21:05.418825Z] Running populate-webroot step. 09:21:05 INFO - Running pre-action listener: _resource_record_pre_action 09:21:05 INFO - Running main action method: populate_webroot 09:21:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:05 INFO - '--tppagecycles', 09:21:05 INFO - '7'], 09:21:05 INFO - 'tests': ['tsvgm']}}, 09:21:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:21:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:21:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:21:05 INFO - 'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:21:05 INFO - 'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['damp', 'tps']}, 09:21:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:21:05 INFO - 'tests': ['damp', 'tps']}, 09:21:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['dromaeo_dom']}, 09:21:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['basic_compositor_video']}, 09:21:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:21:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['a11yr', 09:21:05 INFO - 'ts_paint', 09:21:05 INFO - 'tpaint', 09:21:05 INFO - 'sessionrestore', 09:21:05 INFO - 'sessionrestore_no_auto_restore', 09:21:05 INFO - 'tabpaint']}, 09:21:05 INFO - 'other-e10s': {'tests': ['a11yr', 09:21:05 INFO - 'ts_paint', 09:21:05 INFO - 'tpaint', 09:21:05 INFO - 'sessionrestore', 09:21:05 INFO - 'sessionrestore_no_auto_restore', 09:21:05 INFO - 'tabpaint']}, 09:21:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:21:05 INFO - 'ts_paint', 09:21:05 INFO - 'tpaint', 09:21:05 INFO - 'sessionrestore', 09:21:05 INFO - 'sessionrestore_no_auto_restore', 09:21:05 INFO - 'tabpaint']}, 09:21:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:21:05 INFO - 'ts_paint', 09:21:05 INFO - 'tpaint', 09:21:05 INFO - 'sessionrestore', 09:21:05 INFO - 'sessionrestore_no_auto_restore', 09:21:05 INFO - 'tabpaint']}, 09:21:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['a11yr', 09:21:05 INFO - 'ts_paint', 09:21:05 INFO - 'tpaint', 09:21:05 INFO - 'sessionrestore', 09:21:05 INFO - 'sessionrestore_no_auto_restore', 09:21:05 INFO - 'tabpaint']}, 09:21:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['a11yr', 09:21:05 INFO - 'ts_paint', 09:21:05 INFO - 'tpaint', 09:21:05 INFO - 'sessionrestore', 09:21:05 INFO - 'sessionrestore_no_auto_restore', 09:21:05 INFO - 'tabpaint']}, 09:21:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['tsvgx', 09:21:05 INFO - 'tsvgr_opacity', 09:21:05 INFO - 'tart', 09:21:05 INFO - 'tscrollx', 09:21:05 INFO - 'cart', 09:21:05 INFO - 'tsvg_static']}, 09:21:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:21:05 INFO - 'tsvgr_opacity', 09:21:05 INFO - 'tart', 09:21:05 INFO - 'tscrollx', 09:21:05 INFO - 'cart', 09:21:05 INFO - 'tsvg_static']}, 09:21:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:21:05 INFO - 'talos_options': ['--disable-e10s'], 09:21:05 INFO - 'tests': ['tp5o']}, 09:21:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:21:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:21:05 INFO - 'talos_options': ['--disable-e10s', 09:21:05 INFO - '--xperf_path', 09:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:05 INFO - 'tests': ['tp5n']}, 09:21:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:21:05 INFO - 'talos_options': ['--xperf_path', 09:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:05 INFO - 'tests': ['tp5n']}}, 09:21:05 INFO - 'talos.zip': {'path': '', 09:21:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:05 INFO - Running post-action listener: _resource_record_post_action 09:21:05 INFO - [mozharness: 2016-11-24 17:21:05.438925Z] Finished populate-webroot step (success) 09:21:05 INFO - [mozharness: 2016-11-24 17:21:05.439019Z] Running create-virtualenv step. 09:21:05 INFO - Running pre-action listener: _resource_record_pre_action 09:21:05 INFO - Running main action method: create_virtualenv 09:21:05 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:05 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 09:21:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:05 INFO - Using real prefix '/usr' 09:21:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:06 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:07 INFO - Installing pip.................done. 09:21:08 INFO - Return code: 0 09:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:21:08 INFO - Reading from file tmpfile_stdout 09:21:08 INFO - Output received: 09:21:08 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) 09:21:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21:08 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')]} 09:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:08 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')]} 09:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:08 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 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21:08 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 09:21:08 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 09:21:08 INFO - Using env: {'DISPLAY': ':0', 09:21:08 INFO - 'HOME': '/home/cltbld', 09:21:08 INFO - 'LANG': 'en_US.UTF-8', 09:21:08 INFO - 'LANGUAGE': 'en_US:en', 09:21:08 INFO - 'LOGNAME': 'cltbld', 09:21:08 INFO - 'MAIL': '/var/mail/cltbld', 09:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:08 INFO - 'MOZ_NO_REMOTE': '1', 09:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:08 INFO - 'NO_EM_RESTART': '1', 09:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:08 INFO - 'PWD': '/builds/slave/test', 09:21:08 INFO - 'SHELL': '/bin/bash', 09:21:08 INFO - 'SHLVL': '1', 09:21:08 INFO - 'TERM': 'linux', 09:21:08 INFO - 'TMOUT': '86400', 09:21:08 INFO - 'USER': 'cltbld', 09:21:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:08 INFO - '_': '/tools/buildbot/bin/python'} 09:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:08 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 09:21:08 INFO - Cleaning up... 09:21:08 INFO - Return code: 0 09:21:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:21:08 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')]} 09:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:08 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')]} 09:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:08 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 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21:08 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 09:21:08 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 09:21:08 INFO - Using env: {'DISPLAY': ':0', 09:21:08 INFO - 'HOME': '/home/cltbld', 09:21:08 INFO - 'LANG': 'en_US.UTF-8', 09:21:08 INFO - 'LANGUAGE': 'en_US:en', 09:21:08 INFO - 'LOGNAME': 'cltbld', 09:21:08 INFO - 'MAIL': '/var/mail/cltbld', 09:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:08 INFO - 'MOZ_NO_REMOTE': '1', 09:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:08 INFO - 'NO_EM_RESTART': '1', 09:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:08 INFO - 'PWD': '/builds/slave/test', 09:21:08 INFO - 'SHELL': '/bin/bash', 09:21:08 INFO - 'SHLVL': '1', 09:21:08 INFO - 'TERM': 'linux', 09:21:08 INFO - 'TMOUT': '86400', 09:21:08 INFO - 'USER': 'cltbld', 09:21:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:08 INFO - '_': '/tools/buildbot/bin/python'} 09:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:08 INFO - Downloading/unpacking psutil>=3.1.1 09:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:10 INFO - Installing collected packages: psutil 09:21:10 INFO - Running setup.py install for psutil 09:21:10 INFO - building 'psutil._psutil_linux' extension 09:21:10 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 09:21:10 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 09:21:10 INFO - building 'psutil._psutil_posix' extension 09:21:10 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 09:21:11 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 09:21:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:11 INFO - Successfully installed psutil 09:21:11 INFO - Cleaning up... 09:21:11 INFO - Return code: 0 09:21:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:21:11 INFO - Using env: {'DISPLAY': ':0', 09:21:11 INFO - 'HOME': '/home/cltbld', 09:21:11 INFO - 'LANG': 'en_US.UTF-8', 09:21:11 INFO - 'LANGUAGE': 'en_US:en', 09:21:11 INFO - 'LOGNAME': 'cltbld', 09:21:11 INFO - 'MAIL': '/var/mail/cltbld', 09:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:11 INFO - 'MOZ_NO_REMOTE': '1', 09:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:11 INFO - 'NO_EM_RESTART': '1', 09:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:11 INFO - 'PWD': '/builds/slave/test', 09:21:11 INFO - 'SHELL': '/bin/bash', 09:21:11 INFO - 'SHLVL': '1', 09:21:11 INFO - 'TERM': 'linux', 09:21:11 INFO - 'TMOUT': '86400', 09:21:11 INFO - 'USER': 'cltbld', 09:21:11 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:11 INFO - '_': '/tools/buildbot/bin/python'} 09:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:21:13 INFO - Installing collected packages: mozsystemmonitor 09:21:13 INFO - Running setup.py install for mozsystemmonitor 09:21:13 INFO - Successfully installed mozsystemmonitor 09:21:13 INFO - Cleaning up... 09:21:13 INFO - Return code: 0 09:21:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:21:13 INFO - Using env: {'DISPLAY': ':0', 09:21:13 INFO - 'HOME': '/home/cltbld', 09:21:13 INFO - 'LANG': 'en_US.UTF-8', 09:21:13 INFO - 'LANGUAGE': 'en_US:en', 09:21:13 INFO - 'LOGNAME': 'cltbld', 09:21:13 INFO - 'MAIL': '/var/mail/cltbld', 09:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:13 INFO - 'MOZ_NO_REMOTE': '1', 09:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:13 INFO - 'NO_EM_RESTART': '1', 09:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:13 INFO - 'PWD': '/builds/slave/test', 09:21:13 INFO - 'SHELL': '/bin/bash', 09:21:13 INFO - 'SHLVL': '1', 09:21:13 INFO - 'TERM': 'linux', 09:21:13 INFO - 'TMOUT': '86400', 09:21:13 INFO - 'USER': 'cltbld', 09:21:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:13 INFO - '_': '/tools/buildbot/bin/python'} 09:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:13 INFO - Downloading/unpacking jsonschema==2.5.1 09:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:15 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:16 INFO - warning: no files found matching '*.txt' 09:21:16 INFO - no previously-included directories found matching 'build' 09:21:16 INFO - no previously-included directories found matching 'dist' 09:21:16 INFO - no previously-included directories found matching '.git*' 09:21:16 INFO - Installing collected packages: jsonschema, functools32 09:21:16 INFO - Running setup.py install for functools32 09:21:16 INFO - warning: no files found matching '*.txt' 09:21:16 INFO - no previously-included directories found matching 'build' 09:21:16 INFO - no previously-included directories found matching 'dist' 09:21:16 INFO - no previously-included directories found matching '.git*' 09:21:16 INFO - Successfully installed jsonschema functools32 09:21:16 INFO - Cleaning up... 09:21:16 INFO - Return code: 0 09:21:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:21:16 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')]} 09:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 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')]} 09:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 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 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21:16 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 09:21:16 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 09:21:16 INFO - Using env: {'DISPLAY': ':0', 09:21:16 INFO - 'HOME': '/home/cltbld', 09:21:16 INFO - 'LANG': 'en_US.UTF-8', 09:21:16 INFO - 'LANGUAGE': 'en_US:en', 09:21:16 INFO - 'LOGNAME': 'cltbld', 09:21:16 INFO - 'MAIL': '/var/mail/cltbld', 09:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:16 INFO - 'MOZ_NO_REMOTE': '1', 09:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:16 INFO - 'NO_EM_RESTART': '1', 09:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:16 INFO - 'PWD': '/builds/slave/test', 09:21:16 INFO - 'SHELL': '/bin/bash', 09:21:16 INFO - 'SHLVL': '1', 09:21:16 INFO - 'TERM': 'linux', 09:21:16 INFO - 'TMOUT': '86400', 09:21:16 INFO - 'USER': 'cltbld', 09:21:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:16 INFO - '_': '/tools/buildbot/bin/python'} 09:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:21:16 INFO - Cleaning up... 09:21:16 INFO - Return code: 0 09:21:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21:16 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')]} 09:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 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')]} 09:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 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 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21:16 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 09:21:16 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 09:21:16 INFO - Using env: {'DISPLAY': ':0', 09:21:16 INFO - 'HOME': '/home/cltbld', 09:21:16 INFO - 'LANG': 'en_US.UTF-8', 09:21:16 INFO - 'LANGUAGE': 'en_US:en', 09:21:16 INFO - 'LOGNAME': 'cltbld', 09:21:16 INFO - 'MAIL': '/var/mail/cltbld', 09:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:16 INFO - 'MOZ_NO_REMOTE': '1', 09:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:16 INFO - 'NO_EM_RESTART': '1', 09:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:16 INFO - 'PWD': '/builds/slave/test', 09:21:16 INFO - 'SHELL': '/bin/bash', 09:21:16 INFO - 'SHLVL': '1', 09:21:16 INFO - 'TERM': 'linux', 09:21:16 INFO - 'TMOUT': '86400', 09:21:16 INFO - 'USER': 'cltbld', 09:21:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:16 INFO - '_': '/tools/buildbot/bin/python'} 09:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:16 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:18 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:19 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 09:21:19 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 09:21:19 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 09:21:19 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 09:21:19 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 09:21:19 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 09:21:19 INFO - Downloading docopt-0.6.1.tar.gz 09:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:19 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:19 INFO - Running setup.py install for blobuploader 09:21:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:19 INFO - Running setup.py install for requests 09:21:19 INFO - Running setup.py install for docopt 09:21:20 INFO - Successfully installed blobuploader requests docopt 09:21:20 INFO - Cleaning up... 09:21:20 INFO - Return code: 0 09:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:20 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 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21:20 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 09:21:20 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 09:21:20 INFO - Using env: {'DISPLAY': ':0', 09:21:20 INFO - 'HOME': '/home/cltbld', 09:21:20 INFO - 'LANG': 'en_US.UTF-8', 09:21:20 INFO - 'LANGUAGE': 'en_US:en', 09:21:20 INFO - 'LOGNAME': 'cltbld', 09:21:20 INFO - 'MAIL': '/var/mail/cltbld', 09:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:20 INFO - 'MOZ_NO_REMOTE': '1', 09:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:20 INFO - 'NO_EM_RESTART': '1', 09:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:20 INFO - 'PWD': '/builds/slave/test', 09:21:20 INFO - 'SHELL': '/bin/bash', 09:21:20 INFO - 'SHLVL': '1', 09:21:20 INFO - 'TERM': 'linux', 09:21:20 INFO - 'TMOUT': '86400', 09:21:20 INFO - 'USER': 'cltbld', 09:21:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:20 INFO - '_': '/tools/buildbot/bin/python'} 09:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:20 INFO - Running setup.py (path:/tmp/pip-jAv0V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:20 INFO - Running setup.py (path:/tmp/pip-MIdTU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:20 INFO - Running setup.py (path:/tmp/pip-NT_fqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:20 INFO - Running setup.py (path:/tmp/pip-gWxI1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:20 INFO - Running setup.py (path:/tmp/pip-GBcksU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:20 INFO - Running setup.py (path:/tmp/pip-h5lamH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:20 INFO - Running setup.py (path:/tmp/pip-X1Ecaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:20 INFO - Running setup.py (path:/tmp/pip-pUXRxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:20 INFO - Running setup.py (path:/tmp/pip-_3LbAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:20 INFO - Running setup.py (path:/tmp/pip-SqRq46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:21 INFO - Running setup.py (path:/tmp/pip-EtsLMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:21 INFO - Running setup.py (path:/tmp/pip-lunXML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:21 INFO - Running setup.py (path:/tmp/pip-8M1uk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:21 INFO - Running setup.py (path:/tmp/pip-5LCln8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:21 INFO - Running setup.py (path:/tmp/pip-qZvwxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:21 INFO - Running setup.py (path:/tmp/pip-wsDg0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:21 INFO - Running setup.py (path:/tmp/pip-XeFCYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:21 INFO - Running setup.py install for manifestparser 09:21:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:21 INFO - Running setup.py install for mozcrash 09:21:21 INFO - Running setup.py install for mozdebug 09:21:21 INFO - Running setup.py install for mozdevice 09:21:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:21 INFO - Running setup.py install for mozfile 09:21:22 INFO - Running setup.py install for mozhttpd 09:21:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Running setup.py install for mozinfo 09:21:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Running setup.py install for mozInstall 09:21:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Running setup.py install for mozleak 09:21:22 INFO - Running setup.py install for mozlog 09:21:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Running setup.py install for moznetwork 09:21:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Running setup.py install for mozprocess 09:21:22 INFO - Running setup.py install for mozprofile 09:21:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:22 INFO - Running setup.py install for mozrunner 09:21:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:23 INFO - Running setup.py install for mozscreenshot 09:21:23 INFO - Running setup.py install for moztest 09:21:23 INFO - Running setup.py install for mozversion 09:21:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:23 INFO - Cleaning up... 09:21:23 INFO - Return code: 0 09:21:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:23 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 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21:23 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 09:21:23 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 09:21:23 INFO - Using env: {'DISPLAY': ':0', 09:21:23 INFO - 'HOME': '/home/cltbld', 09:21:23 INFO - 'LANG': 'en_US.UTF-8', 09:21:23 INFO - 'LANGUAGE': 'en_US:en', 09:21:23 INFO - 'LOGNAME': 'cltbld', 09:21:23 INFO - 'MAIL': '/var/mail/cltbld', 09:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:23 INFO - 'MOZ_NO_REMOTE': '1', 09:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:23 INFO - 'NO_EM_RESTART': '1', 09:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:23 INFO - 'PWD': '/builds/slave/test', 09:21:23 INFO - 'SHELL': '/bin/bash', 09:21:23 INFO - 'SHLVL': '1', 09:21:23 INFO - 'TERM': 'linux', 09:21:23 INFO - 'TMOUT': '86400', 09:21:23 INFO - 'USER': 'cltbld', 09:21:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:23 INFO - '_': '/tools/buildbot/bin/python'} 09:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:23 INFO - Running setup.py (path:/tmp/pip-dLttOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:23 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)) 09:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:23 INFO - Running setup.py (path:/tmp/pip-2oV8OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:23 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)) 09:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:23 INFO - Running setup.py (path:/tmp/pip-mJLrle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:23 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)) 09:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:23 INFO - Running setup.py (path:/tmp/pip-vXDK1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:23 INFO - Running setup.py (path:/tmp/pip-ylzDWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:23 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)) 09:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:23 INFO - Running setup.py (path:/tmp/pip-QxNchB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:23 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)) 09:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:24 INFO - Running setup.py (path:/tmp/pip-LSs5ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:24 INFO - Running setup.py (path:/tmp/pip-qR9ivu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:24 INFO - Running setup.py (path:/tmp/pip-5j_zte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:24 INFO - Running setup.py (path:/tmp/pip-QSfm61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:24 INFO - Running setup.py (path:/tmp/pip-et7yTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:24 INFO - Running setup.py (path:/tmp/pip-sBGs3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:24 INFO - Running setup.py (path:/tmp/pip-QmnENV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:24 INFO - Running setup.py (path:/tmp/pip-NSpmR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:24 INFO - Running setup.py (path:/tmp/pip-Eyo5l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:24 INFO - Running setup.py (path:/tmp/pip-olMTyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:24 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)) 09:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:24 INFO - Running setup.py (path:/tmp/pip-HXGzAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:24 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)) 09:21:24 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)) 09:21:24 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)) 09:21:24 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)) 09:21:24 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:24 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:26 INFO - Downloading blessings-1.6.tar.gz 09:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:26 INFO - Installing collected packages: blessings 09:21:26 INFO - Running setup.py install for blessings 09:21:26 INFO - Successfully installed blessings 09:21:26 INFO - Cleaning up... 09:21:26 INFO - Return code: 0 09:21:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:27 INFO - Reading from file tmpfile_stdout 09:21:27 INFO - Current package versions: 09:21:27 INFO - argparse == 1.2.1 09:21:27 INFO - blessings == 1.6 09:21:27 INFO - blobuploader == 1.2.4 09:21:27 INFO - docopt == 0.6.1 09:21:27 INFO - functools32 == 3.2.3-2 09:21:27 INFO - jsonschema == 2.5.1 09:21:27 INFO - manifestparser == 1.1 09:21:27 INFO - mozInstall == 1.12 09:21:27 INFO - mozcrash == 1.0 09:21:27 INFO - mozdebug == 0.1 09:21:27 INFO - mozdevice == 0.49 09:21:27 INFO - mozfile == 1.2 09:21:27 INFO - mozhttpd == 0.7 09:21:27 INFO - mozinfo == 0.9 09:21:27 INFO - mozleak == 0.1 09:21:27 INFO - mozlog == 3.4 09:21:27 INFO - moznetwork == 0.27 09:21:27 INFO - mozprocess == 0.23 09:21:27 INFO - mozprofile == 0.28 09:21:27 INFO - mozrunner == 6.13 09:21:27 INFO - mozscreenshot == 0.1 09:21:27 INFO - mozsystemmonitor == 0.3 09:21:27 INFO - moztest == 0.7 09:21:27 INFO - mozversion == 1.4 09:21:27 INFO - psutil == 3.1.1 09:21:27 INFO - requests == 1.2.3 09:21:27 INFO - wsgiref == 0.1.2 09:21:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:27 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 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21:27 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 09:21:27 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 09:21:27 INFO - Using env: {'DISPLAY': ':0', 09:21:27 INFO - 'HOME': '/home/cltbld', 09:21:27 INFO - 'LANG': 'en_US.UTF-8', 09:21:27 INFO - 'LANGUAGE': 'en_US:en', 09:21:27 INFO - 'LOGNAME': 'cltbld', 09:21:27 INFO - 'MAIL': '/var/mail/cltbld', 09:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:27 INFO - 'MOZ_NO_REMOTE': '1', 09:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:27 INFO - 'NO_EM_RESTART': '1', 09:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:27 INFO - 'PWD': '/builds/slave/test', 09:21:27 INFO - 'SHELL': '/bin/bash', 09:21:27 INFO - 'SHLVL': '1', 09:21:27 INFO - 'TERM': 'linux', 09:21:27 INFO - 'TMOUT': '86400', 09:21:27 INFO - 'USER': 'cltbld', 09:21:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:27 INFO - '_': '/tools/buildbot/bin/python'} 09:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:27 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)) 09:21:27 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)) 09:21:27 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)) 09:21:27 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)) 09:21:27 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)) 09:21:27 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)) 09:21:27 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)) 09:21:27 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)) 09:21:27 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)) 09:21:27 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)) 09:21:27 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)) 09:21:27 INFO - Cleaning up... 09:21:27 INFO - Return code: 0 09:21:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e7d495e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, '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': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', '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 09:21: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'] in /builds/slave/test/build 09:21: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 09:21:27 INFO - Using env: {'DISPLAY': ':0', 09:21:27 INFO - 'HOME': '/home/cltbld', 09:21:27 INFO - 'LANG': 'en_US.UTF-8', 09:21:27 INFO - 'LANGUAGE': 'en_US:en', 09:21:27 INFO - 'LOGNAME': 'cltbld', 09:21:27 INFO - 'MAIL': '/var/mail/cltbld', 09:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:27 INFO - 'MOZ_NO_REMOTE': '1', 09:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:27 INFO - 'NO_EM_RESTART': '1', 09:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:27 INFO - 'PWD': '/builds/slave/test', 09:21:27 INFO - 'SHELL': '/bin/bash', 09:21:27 INFO - 'SHLVL': '1', 09:21:27 INFO - 'TERM': 'linux', 09:21:27 INFO - 'TMOUT': '86400', 09:21:27 INFO - 'USER': 'cltbld', 09:21:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:27 INFO - '_': '/tools/buildbot/bin/python'} 09:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:21:27 INFO - Cleaning up... 09:21:27 INFO - Return code: 0 09:21:27 INFO - Running post-action listener: _resource_record_post_action 09:21:27 INFO - Running post-action listener: _start_resource_monitoring 09:21:27 INFO - Starting resource monitoring. 09:21:27 INFO - [mozharness: 2016-11-24 17:21:27.724156Z] Finished create-virtualenv step (success) 09:21:27 INFO - [mozharness: 2016-11-24 17:21:27.724681Z] Running install step. 09:21:27 INFO - Running pre-action listener: _resource_record_pre_action 09:21:27 INFO - Running main action method: install 09:21:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:27 INFO - Reading from file tmpfile_stdout 09:21:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:28 INFO - Reading from file tmpfile_stdout 09:21:28 INFO - Output received: 09:21:28 INFO - Usage: mozinstall [options] installer 09:21:28 INFO - Options: 09:21:28 INFO - -h, --help show this help message and exit 09:21:28 INFO - -d DEST, --destination=DEST 09:21:28 INFO - Directory to install application into. [default: 09:21:28 INFO - "/builds/slave/test"] 09:21:28 INFO - --app=APP Application being installed. [default: firefox] 09:21:28 INFO - mkdir: /builds/slave/test/build/application 09:21:28 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'] 09:21:28 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 09:21:44 INFO - Reading from file tmpfile_stdout 09:21:44 INFO - Output received: 09:21:44 INFO - /builds/slave/test/build/application/firefox/firefox 09:21:44 INFO - Running post-action listener: _resource_record_post_action 09:21:44 INFO - [mozharness: 2016-11-24 17:21:44.043510Z] Finished install step (success) 09:21:44 INFO - [mozharness: 2016-11-24 17:21:44.043752Z] Running run-tests step. 09:21:44 INFO - Running pre-action listener: _resource_record_pre_action 09:21:44 INFO - Running main action method: run_tests 09:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:44 INFO - Python 2.7.3 09:21:44 INFO - Return code: 0 09:21:44 INFO - grabbing minidump binary from tooltool 09:21:44 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')]} 09:21:44 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 0x103efc0>, '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 0x103fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:44 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 09:21:44 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 09:21:44 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 09:21:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:44 INFO - Return code: 0 09:21:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:21:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:21:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 09:21:44 INFO - Using env: {'DISPLAY': ':0', 09:21:44 INFO - 'HOME': '/home/cltbld', 09:21:44 INFO - 'LANG': 'en_US.UTF-8', 09:21:44 INFO - 'LANGUAGE': 'en_US:en', 09:21:44 INFO - 'LOGNAME': 'cltbld', 09:21:44 INFO - 'MAIL': '/var/mail/cltbld', 09:21:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:44 INFO - 'MOZ_NO_REMOTE': '1', 09:21:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:44 INFO - 'NO_EM_RESTART': '1', 09:21:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:44 INFO - 'PWD': '/builds/slave/test', 09:21:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:44 INFO - 'SHELL': '/bin/bash', 09:21:44 INFO - 'SHLVL': '1', 09:21:44 INFO - 'TERM': 'linux', 09:21:44 INFO - 'TMOUT': '86400', 09:21:44 INFO - 'USER': 'cltbld', 09:21:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442', 09:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:44 INFO - '_': '/tools/buildbot/bin/python'} 09:21:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:21:44 INFO - mozversion application_buildid: 20161124080519 09:21:44 INFO - mozversion application_changeset: bad312aefb42982f492ad2cf36f4c6c3d698f4f7 09:21:44 INFO - mozversion application_display_name: Nightly 09:21:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:44 INFO - mozversion application_name: Firefox 09:21:44 INFO - mozversion application_remotingname: firefox 09:21:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:21:44 INFO - mozversion application_vendor: Mozilla 09:21:44 INFO - mozversion application_version: 53.0a1 09:21:44 INFO - mozversion platform_buildid: 20161124080519 09:21:44 INFO - mozversion platform_changeset: bad312aefb42982f492ad2cf36f4c6c3d698f4f7 09:21:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:21:44 INFO - mozversion platform_version: 53.0a1 09:21:44 INFO - using testdate: 1480008104 09:21:44 INFO - actual date: 1480008104 09:21:44 INFO - starting webserver on 'localhost:41045' 09:21:44 INFO - SUITE-START | Running 2 tests 09:21:44 INFO - TEST-START | dromaeo_css 09:21:44 INFO - operating with platform_type : linux_ 09:21:44 INFO - Initialising browser for dromaeo_css test... 09:21:44 INFO - TEST-INFO | started process 20610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6xCQGL/profile http://localhost:41045/getInfo.html) 09:21:48 INFO - PROCESS | 20610 | __metrics Screen width/height:1600/1200 09:21:48 INFO - PROCESS | 20610 | colorDepth:24 09:21:48 INFO - PROCESS | 20610 | Browser inner width/height: 1024/697 09:21:48 INFO - PROCESS | 20610 | __metrics 09:21:48 INFO - PROCESS | 20610 | 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" 09:21:48 INFO - PROCESS | 20610 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:21:49 INFO - PROCESS | 20610 | console.error: PushService: 09:21:49 INFO - PROCESS | 20610 | stateChangeProcessEnqueue: Error transitioning state 09:21:49 INFO - PROCESS | 20610 | UnknownError 09:21:50 INFO - TEST-INFO | 20610: exit 0 09:21:50 INFO - Browser initialized. 09:21:50 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:50 INFO - TEST-INFO | started process 20690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6xCQGL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:02 INFO - PROCESS | 20690 | RSS: Main: 174616576 09:22:02 INFO - PROCESS | 20690 | 09:22:54 INFO - PROCESS | 20690 | 1480008174110 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] 09:25:07 INFO - PROCESS | 20690 | Cycle 1(1): loaded http://localhost:41045/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41045/tests/dromaeo/cssquery-ext.html) 09:25:08 INFO - PROCESS | 20690 | RSS: Main: 298180608 09:25:08 INFO - PROCESS | 20690 | 09:28:11 INFO - PROCESS | 20690 | Cycle 1(1): loaded http://localhost:41045/tests/dromaeo/cssquery-ext.html (next: http://localhost:41045/tests/dromaeo/cssquery-jquery.html) 09:28:12 INFO - PROCESS | 20690 | RSS: Main: 279625728 09:28:12 INFO - PROCESS | 20690 | 09:31:14 INFO - PROCESS | 20690 | Cycle 1(1): loaded http://localhost:41045/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41045/tests/dromaeo/cssquery-mootools.html) 09:31:15 INFO - PROCESS | 20690 | RSS: Main: 255897600 09:31:15 INFO - PROCESS | 20690 | 09:34:17 INFO - PROCESS | 20690 | Cycle 1(1): loaded http://localhost:41045/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41045/tests/dromaeo/cssquery-prototype.html) 09:34:17 INFO - PROCESS | 20690 | RSS: Main: 221003776 09:34:17 INFO - PROCESS | 20690 | 09:37:21 INFO - PROCESS | 20690 | Cycle 1(1): loaded http://localhost:41045/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41045/tests/dromaeo/cssquery-yui.html) 09:37:21 INFO - PROCESS | 20690 | RSS: Main: 218066944 09:37:21 INFO - PROCESS | 20690 | 09:40:24 INFO - PROCESS | 20690 | Cycle 1(1): loaded http://localhost:41045/tests/dromaeo/cssquery-yui.html (next: http://localhost:41045/tests/dromaeo/cssquery-dojo.html) 09:40:24 INFO - PROCESS | 20690 | RSS: Main: 311754752 09:40:24 INFO - PROCESS | 20690 | 09:40:24 INFO - PROCESS | 20690 | __start_tp_report 09:40:24 INFO - PROCESS | 20690 | _x_x_mozilla_page_load 09:40:24 INFO - PROCESS | 20690 | _x_x_mozilla_page_load_details 09:40:24 INFO - PROCESS | 20690 | |i|pagename|runs| 09:40:24 INFO - PROCESS | 20690 | |0;dojo.html;2558.475512519933;2588.352911772057;2603.362176266815;2619.5022945640326;2627.448235870467;4535.569120933506;4619.7921093550785;4624.028953919673;4636.09596128755;4638.8840278993;4648.65135114866;4675;4691.460482044566;4735.5974742146955;4823.324734537159;4243.469566304212;4274.123804620045;4309.741415515064;4342.913141737179;4426.092651006536;3951.269015232177;4272.87181384559;4396.494403143632;4436.979494716217;4470.843520476784;4190.895227619334;4237.618614324695;4381.408509851193;4417.9116417671785;4448.0436706108185;4280.443542339507;4290.635295999844;4298.161858437606;4301.161273551658;4301.268784306675;4265.722728022669;4279.465066866642;4280.571942805695;4282.785860706983;4284.67864910133;4608;4613.238815595423;4613.769311534444;4618.399608050931;4631.513691062457;4938.654294199408;4982.57648099912;5063.873403164914;5063.873403164914;5065.493450654905;5013.047520971004;5027.245913113025;5028.7737051832755;5069.518395752398;5077.466865979093;4643.976780116078;4681.204195286809;4694.460137084279;4695.647826413033;4737.976310118427;4980;5037.244413338029;5039.319691841554;5144.6655967362;5183.533481986639;4874.829380971649;4875.049365373789;4911.50884911506;4945.901081978341;4994.600431965434;5010.69935803853;5023.899522009539;5025.3718285214345;5025.422076461254;5066.544011039025;4820.421549414093;4974;4977.800887964513;4980.526849949249;5025.974870125626;4846.321514987904;4913.213885778258;4925.38432695913;4942.4316203637045;4965.428975667773;4221.767802770815;4221.87334379963;4223.239816832938;4259.957400425956;4263.680223983151;3672.6878215351994;3703.9074023149637;3704.129529560551;3734.5705243896755;3741.5323084614424;4241.575842415734;4256.8297268109545;4279.957200428018;4281.336392859112;4352.477702675636;4951.3810773653295;4966.553010229097;4980.103581355391;4986.376702912136;5018.473060328686;4263.658907287409;4270.615644592001;4275.679324050709;4301.44081269433;4310.655147588185;4358.21552120615;4403.823847046082;4455.398521199597;4455.6212721918355;4460.576245256695;4621.6302695784925;4659.720416775004;4662.207424737735;4675.602573781131;4730.337752714691;4974.303597496281;4979.253112033224;4986.426560945392;4991.376077990251;5029.974850125873;4579;4671.135839869635;4680.648951328596;4683.110209060268;4729.5034021427255;4767.952320476889;4815.30178124177;4842.4189097308545;4862.562369386772;4942.406911170682;4948.950510494993;4960.677555958851;4967.677100988569;4971.304017437489;5045.041442125985;4814.975925120352;4870.878228044186;4879.194932836184;4880.097182021337;4920.21276595743;4688.507706690748;4740.431148262231;4791;4826.372571565815;4840.661153719206;4788.712677239377;4790.281457781221;4792.688475249098;4795.976020119877;4826.782794774173;4911.901761964812;4929.605631549539;4929.802807887644;4931.334269873521;4974.527419895104;4664.7667616618355;4722.315264286728;4740.715557066587;4756.7145971241835;4810.254410566367 09:40:24 INFO - PROCESS | 20690 | |1;ext.html;550.2324257660563;565.4430386069722;566.8441178675863;569.5159114752461;578.2367275196737;27244.86377568112;30067;40334.79832600833;41979.58020419795;42024.15951680965;38863.61136388635;39204.803975980154;39219.80390098053;39247.41128883062;39252.60747392525;7564.735234266802;7713.42149338799;7715.575643339614;7716.459847810655;7720.691172353099;7450.366718828879;7653.15815260321;9750.219982401426;10164.593416263378;10165.593376264978;10077.395356278646;10123;10138.03688649577;10139.746506337327;10142.695719128402;9899.45552994585;9938.503074846301;9958.103770660602;9959.651412200574;9967.40195588267;9875.308728389016;9944.204463642964;9950.154236889874;9951.950240248825;9952.402855828674;36246.09384765402;36326.45510317347;36512.634873651186;36555;36690.266194676224;2923.8976635817644;3022.8488575571355;3051.4354844353866;3082.307891745279;3248.561444205049;27668.58497122545;27710.307242319104;27911.720882791116;28576;29177.124686259445;3411.249525104473;3433.725301975861;3482.6343233960324;3608.4767708682093;3628.2380700053022;233780;234534;236434;236526.8173659138;237015;51099.48900510947;51445.742771285906;51521.7423912878;51552.96894062098;51553;53574.46425535773;53639;53685.46314536883;53707.46292537103;53716;14544.927275363556;14824.258787060604;14843.554693359001;14847.109173449411;14848.40606375733;9247.306452016126;9452.52737363129;11460.770784584261;11529.48117334722;11543.711407214887;16154;16530;16588.50234492967;16902.57743556421;17125.743113853303;5846.795362162304;5960.970195148997;5989.760409583655;6017.729202185912;6149.41580549847;780.8243145292264;838.5304229631304;904.4980036079908;918.1919910478736;920.3879420185501;25208.36979075538;27110.728892711213;27239.86380068087;27297.454050919267;27613.30966725848;934.4066517761271;946.342292106979;954.5895265036102;971.6064993677572;1033.3180101133366;14035.929820351037;14287.928560357132;14306.28468576567;14705.852941470663;14726.705465890836;309201;309587;310793;311657;311924;46483.76758116255;46503;46523.30215046777;46666.766666166455;46685.76657116761;996.2577879479834;1096.4298564746287;1098.214776434821;1169.8245263210417;1189.9226550274204;25313;28134.2966425841;28268.717312826608;30831.537526936667;31145.84427077941;44837.10325793531;45386.09227815359;45638.08723825571;45766;45835.54164458446;290545;292964;293290;293920;294405;21770.782292177508;22232.888835556365;23787.788648532918;24493.51012979766;34986;39191.804040979616;40699.79650101849;40898.79550602228;44076;44161;33862.32275354528;34628.82685586556;34931.301373972885;34947.65052349546;35382.46926296056;34131.82934085314;34674.47988280228;34754.478682819274;35126;35396.82301588476;32343.280522739245;32371.51442728314;33526.66473335236;33550.66449335475;34902;29340.266493336985;31579.36841263116;31615;31637.8418107908;31842.363152737278;24242.666254037176;24741.62887556724;24744;24744.381390465383;24906 09:40:24 INFO - PROCESS | 20690 | |2;jquery.html;340.290494319344;348.52948519498676;354.7499013195698;357.79963220596454;366.92844895245423;12707.745845083116;13276.601701948957;15545.689086218268;16344.75482867758;16828.74756878648;15182.772258416133;15581.844181558181;15843.524694259191;16913.40803071893;17054.062026588534;3957.4261732048835;4813.470518242999;5032.84901452957;5041.193409054552;5041.798328066873;4952.851414457572;5018.623603229754;5030.396352437694;5031.4465408805;5041.8487445376695;5002.249662550628;5002.349694539705;5005.074061298653;5006.1990081586955;5007.774650140735;4760.428748550179;4919.2290775321035;4931.556159945586;4940.629452791055;4942.085714142895;4393.099414620027;4400.075984043355;4402.119576084764;4403.3174857897075;4403.647708183337;20381.79618203814;20405.79594204054;20549.280775172945;20668.48328791777;20863.8956805215;1841.9815801841944;1915.348781414326;2039.1843262694892;2107.926222582202;2341.934419838969;12061.33662648554;13155.73688526224;13530.594082177451;13563.050586458952;13797.655058623615;1646.3990643415186;1685.3511398111693;1692.1708362902211;1696.1095424901903;1728.7752592163065;66004.3399566003;67505.32494675039;67812.32187678109;68276.6586167071;69559.30440695629;8877.511736854534;9022.729318120468;9073.183413492818;9276.90723092774;9532.995177531851;10687.946560267148;12600.369981501071;12601.873981260253;12602.621921342374;12624.116311858266;6234.906476402857;6827.897581536281;7221.602811845294;7288.161861385903;7375.668094935633;6933.514653974275;7001.124859392576;7224.096987876515;7264;7265.600391978492;5904.911426328608;6031.065184896348;6038.698065096728;6068.787592434332;6098.32918378978;1674.4390629139375;1682.470021943084;1686.249618919569;1693.889897156681;1702.4892532240278;872.5462759365222;875.1511034296722;875.5578432891349;909.5997760985277;957.4111921168432;16557.337706491846;16845.83154168467;17598;17694.734578981326;18092.185851636707;848.7920459487465;856.6230858422274;868.4962721621445;876.1282523888772;881.8015946412006;9459.38513996588;10077.69766906994;10216.284860059874;10229.335093218917;10232.53953572091;314585;323651;347662;350107;350721;60964.39035609676;64842;64907.512756433134;65020.34979650238;67790.32209677939;874.7594411536751;875.4090988582681;904.6517090919912;906.4606559097326;906.7370462565914;15233.734554324807;15285.082895026335;15818.209089545246;15831.445899393466;16080.597985050468;33748.325033499685;33880.32239355249;34102;34655.480167796995;34871.65128348684;31769.36461270808;34562.13594660053;40368.39447408233;41926.371104432845;44619;6865.794026179223;7177.282271772781;7205.639718013974;7231.4214862811905;7411.370033547209;10736.785264294827;11692.883071169179;12061;12621.621351359474;12655.810162847749;9902.900970990486;10213.948930255301;10375.792484150124;10506.947465262625;10896.945515272373;10086.940871208417;10387.169026478015;10398.324108933199;10432.478376081013;10980.670579882617;10441.582336706446;10523.737396459797;10724.517396717323;10830.891691083303;10832.458377081271;7481.289277518627;7597.6201189941385;7705.190954949874;7765.92234077652;7801.804954876174;10698.251122421356;10721.839172412576;10794.352338859693;10855.511501982272;11083.334999900031 09:40:24 INFO - PROCESS | 20690 | |3;mootools.html;1312.0422091872933;1358.1850889466318;1415.5257988573828;1609.5734630322975;1655.3461382753806;6439.581427207228;6669;6704.12846329977;7068.964655176724;7069.505134640577;6944.791656250308;7201.855962880739;7206.4595155363295;7376.151742549609;7378.74174403896;2094.2774742713777;2136.6794980752934;2138.0592539282743;2138.3905586907736;2138.4546940530145;1817.800041995386;1911.3596945023435;2080.9791902080938;2111.0711287033732;2132.8826914519695;2016.5563576013253;2094.8428867834896;2101.642720737478;2102.98948505258;2104.189886893542;2083.9270625528034;2086.906089225981;2092.98490232238;2101.338078505266;2113.8520303578757;2042;2094.86383385081;2094.979050209509;2097.056324653897;2097.674860396641;7198.460115491359;7244.203137654854;7255.419566434673;7260.818479538054;7263.709451621929;4045.4708957687767;4249.532551419341;4349.869503914888;4360.607545320905;4362.432883725127;2542.2627438042946;2585.767280944724;2595.078747044791;2606.2311618072713;2613.4119823039855;761.3034073822446;810.8350703621345;845.0873057098319;846.2003406780594;849.817289282801;9652.517374131336;9652.613895444174;9666.95166524163;9680.564374603231;9685.225181985496;3561.6082230954576;3800.258949504875;3902.3366027775346;3911.4523966644692;3953.3081710700512;8385.706500272461;8388.07731149573;8388.203120703523;8396.328293736486;8407.285380742705;4384.167008268419;4390.100029493946;4392.9121417572105;4394.428724265889;4394.494633117232;3847.8076096195637;4032.838686452568;4034.092329225901;4044.373122166069;4045.0494133878515;3305.743817349392;3321.0534997525588;3396.2698019925833;3404.2340473393288;3404.8297585120645;948.3029972969862;996.9900300997042;1056.2078441169124;1086.5490821309068;1086.6088208245026;564.6011013697599;724.5109551053018;850.4429598612918;853.5220276645099;855.6192494340083;4964;4979.502049794992;5041.395032596039;5050.419201791768;5162.096633089194;822.1572887789944;872.9170728780756;883.3154305413227;886.7871710789364;907.6051917415945;3312.801231926092;3346.1801858544327;3371.292028674006;3398.337324221753;3500.054985153994;8431.283340915968;8799.428037177562;8826.602802873886;8847.42491738035;8862.822743545094;8777;8779.517126557972;8780.868286975701;8783;8807.823843523094;6783.050372947791;6873.896891546631;6880.483963702743;6891.104156459728;6894.655267236719;4787.712737235777;4811.49479304668;4816.123413784523;4893.657443978887;5028.069807085701;7964.522128672298;7991.720289790062;8000.159983201913;8006.079300880473;8014.118446970712;7869.6458659361615;8027.719029834161;8056;8077.474964127313;8166.183381661786;6075.301340345917;6154.753809847735;6157.476614487639;6164.4143806338325;6169.784057557964;6686.097376854257;6713.160854893138;6870.038194652652;6905.827354316182;6914.9308506914285;4940.481249468754;6077.817665470043;6092.238470191226;6134.8159555213415;6281.246250449975;5888.146218798336;5954.7320370582565;5954.880902382015;6088.452039316483;6134.570580059353;5581.358143813513;5719.971400142973;5758.971205144115;5761.5102716269585;5766.70249193928;3843.2889915365745;4106.609872062149;4152.522459917148;4236.766977816126;4348.326009468537;4170.4995400552125;4181.874543763692;4268.679849011399;4340.6744494163695;4500.054988452331 09:40:24 INFO - PROCESS | 20690 | |4;prototype.html;265.5379639427397;265.79799352492114;268.1018587731101;271.05132037867463;276.3616046931589;4718.622510199184;4768.284757286408;4785.377900872891;4792.568668819806;4803.327534145214;4706.658602298346;4711.623070154388;4712.316714076457;4728.267118596615;4731.5978141857895;3493.755437119403;3597.6402359763947;3705.4627079073516;3706.7034637229026;3707.461403517537;3536.9389183245053;3640.76335038223;3658.7804731716183;3660.3777357849094;3667.8166091695443;3623.7825730456125;3631.5460567429072;3632.237230181665;3633.164372194397;3641.035125691694;3474.774139680913;3632.1827588792576;3642.7267954903223;3644.669695561128;3651.7443778935485;3105.394448082625;3114.6418161911442;3177.3009937813645;3215.2283451971357;3217.581714377116;4567.543245675439;4586.266197408432;4587.24310488769;4595.7702114894455;4598.839040633595;4132.194222126686;4149.613971966131;4154.896127596804;4166.7708276044805;4187.51843537994;4769.880752981203;4840.5159484051665;4884.6092312615265;4886.218205087169;4890.388701412324;3443.500692399588;3449.6029108211214;3454.222799870034;3458.9654103458893;3472.618012018676;5157.143428365785;5163.66436181647;5165.121929272071;5168.3539557555305;5173.896522069575;3425.1779572902824;3523.612402635708;3539.292141571696;3540.3627347077772;3602.4776407420777;3624.7643903146213;3644.85420583179;3647.361711700442;3651.1419816343137;3652.4521321801944;4122.835086596562;4150.149219410014;4163.333866581333;4171.561985991488;4175.791210439465;4945.7774400152075;4954.20732682769;4967.751612419437;4970.403551573762;4972;1184.802325870341;1227.4537830665267;1229.5757963502576;1235.4618499967419;1238.4952282976228;793.4604468961046;815.6288888555812;816.77946954322;825.2572684583922;826.8635675113538;4239.788010599457;4271.402003719481;4279.336702811007;4294.656427485794;4297.484301883794;4912.592829513585;4993.825216117419;5056.317397151411;5133.435322114565;5147.382314122329;4384.12317536494;4391.626711729475;4398.274284743045;4406.647468202536;4414.690971631955;2576.9871150644126;2600.2849216465625;2612.798112868064;2619.3189770659383;2642.5771876499666;4587.79354929029;4686.742229177428;4694.577488026094;4707.646926480459;4719.362886010414;5021.623378246646;5036.61493089396;5049.889024414623;5051.974740126349;5075.746212689351;4682.695624784378;4697.389339385858;4697.8658780273145;4699.475393454909;4707.435107787019;4820.228763397839;5147.202183661539;5163.974180129076;5172.301739265151;5182.274481572658;5061.443241243386;5074.5686616637995;5077.619178561548;5082.923756143735;5083.771230294572;4639.5360463954685;4871.756412179448;4881.438634557071;4886.144924638103;4894.412670479565;3504.8247587621026;3541.11472131967;3544.663256990582;3551.271989242251;3552.609212986518;5152;5155.561777248826;5159.613029022763;5164.7934082636275;5170.7156106413;4829.203181475158;4983.775730092227;4988.750562471934;5033.370828646419;5044.243363495505;4904.950950490449;4969.937475947441;4998.2002879539095;5009;5014.323066386137;4886.144924638245;4908.4355299139625;4910.017996400806;4915.975420122876;4937.5556199942175;4914.483979182134;5013.699178049183;5031.176306007387;5036.445990941067;5055.292259083658;4674.392328997209;4757.976210118927;4824.517548245148;4902.088185607688;4953.975230123826 09:40:24 INFO - PROCESS | 20690 | |5;yui.html;629.7701339011262;654.4764188649079;668.3717305732611;669.1869378704874;686.1286166568461;11858.584949526768;12713.682157946056;12997.545085921995;13124.475020999173;13138.343082845868;11995.340256285901;12145.635630931065;12150.635480935563;12176.208546444475;12181.20822146562;609.874975629997;632.1813251838856;750.9436792240576;766.2835249042136;768.2202564397113;750.8723517002122;776.510798197135;786.34340325828;788.4993029426327;789.2305002622454;815.9637260678963;817.2113910076804;818.1409520004001;818.5497976113114;818.9017317921857;636.5353292096795;657.5955787190891;803.4897839871694;803.8191406933394;804.6057431858377;562.8058319879635;578.3175852494055;586.1061880632028;586.2876604925036;586.4604563801313;12566.74866502674;12619.432125554373;12646.241225526406;12649.557265495756;12667.556635517805;11948.820767688492;12116.273023618523;12434.75130497385;12469.189502682388;12635.305058221795;10610.893891061145;10664.360138391721;11031;11047.558097676083;11452;4007.779572123532;4023.7988100594853;4028.738132021409;4100.753954762724;4146.854860079913;46388;47162;47392;47809;48373.75813120912;9852.753681158028;10053.748656283651;10057.245706572035;10093.545790439448;10230.335028223142;17812.55468613295;17900.373486927896;17946.55133621644;18039.278428862963;18071.27714891416;6576.638284894377;6653.700583473756;6662.100616416818;6712.697928593225;6831.11195544576;3521.4893840393;3731.552213734315;3737.6075512071384;3745.419459983707;3771.264603402365;2571.7171111177754;2644.405008872988;2659.002873922279;2663.480621278832;2665.3070201747687;438.52639149718226;490.291528740973;511.93179554599004;519.781394796249;525.1440152551316;485.34236110070344;565.0507147991332;566.2808233543377;603.6800495737266;608.3095686395884;7316.158641756159;7335.706571737071;7736.613169341623;7967.3626109911065;7980.720674776355;572.2602790762431;573.6816067082809;578.7598146769128;591.2432086928738;594.4471641373564;3523.3481805865486;3829.7702137871815;3847.2882516734494;3871.7483363581277;3981.7810020448574;68573.65713171502;68918.31081689119;69039;69411.65294173497;69749;38307.23385532274;54450.18324725132;60289.39710602925;61637.383626163166;61879.57445106526;55878;56177;56435;56917.43082569121;58728.41271587315;6863.553868998499;7306;7370.926290737024;7457.32884040439;7659.502132361378;24894.12870549522;26512.469750604494;34309;35467.46798797968;35526.46710299296;42460.78769606132;44238.557614423444;46919.530804692884;47294;48019.279710805065;8674.609642566225;8822.64709411642;8925.375223734276;9145.222656074307;9162.450252984841;9724.222062235145;10222.948885255526;10421.583136674448;10427;10484.528196231035;8220;8300.626471808662;8403.327733781405;8620.310375169845;8624.655013799378;9356.95321523388;9365.625374985197;9436.480993545421;9552.665656701982;9582.233421326417;7887.211278872067;8168.224018718212;8179.182081791773;8358.958205208935;8488.533130677872;7634.580098094658;7721.498102623312;7873.606319684108;8083.6766529338165;8167.714130005421;7766.339861111869;7857.349956509197;8038.31674307667;8134.593270336341;8182.099969003286 09:40:24 INFO - PROCESS | 20690 | __end_tp_report 09:40:24 INFO - PROCESS | 20690 | __start_cc_report 09:40:24 INFO - PROCESS | 20690 | _x_x_mozilla_cycle_collect,1229 09:40:24 INFO - PROCESS | 20690 | __end_cc_report 09:40:24 INFO - PROCESS | 20690 | __startTimestamp1480009224888__endTimestamp 09:40:24 INFO - PROCESS | 20690 | 09:40:24 INFO - PROCESS | 20690 | ------- Summary: start ------- 09:40:24 INFO - PROCESS | 20690 | Number of tests: 6 09:40:24 INFO - PROCESS | 20690 | 09:40:24 INFO - PROCESS | 20690 | [#0] dojo.html Cycles:165 Average:4604.15 Median:4722.32 stddev:481.71 (10.2%) stddev-sans-first:455.68 09:40:24 INFO - PROCESS | 20690 | Values: 2558.5 2588.4 2603.4 2619.5 2627.4 4535.6 4619.8 4624.0 4636.1 4638.9 4648.7 4675.0 4691.5 4735.6 4823.3 4243.5 4274.1 4309.7 4342.9 4426.1 3951.3 4272.9 4396.5 4437.0 4470.8 4190.9 4237.6 4381.4 4417.9 4448.0 4280.4 4290.6 4298.2 4301.2 4301.3 4265.7 4279.5 4280.6 4282.8 4284.7 4608.0 4613.2 4613.8 4618.4 4631.5 4938.7 4982.6 5063.9 5063.9 5065.5 5013.0 5027.2 5028.8 5069.5 5077.5 4644.0 4681.2 4694.5 4695.6 4738.0 4980.0 5037.2 5039.3 5144.7 5183.5 4874.8 4875.0 4911.5 4945.9 4994.6 5010.7 5023.9 5025.4 5025.4 5066.5 4820.4 4974.0 4977.8 4980.5 5026.0 4846.3 4913.2 4925.4 4942.4 4965.4 4221.8 4221.9 4223.2 4260.0 4263.7 3672.7 3703.9 3704.1 3734.6 3741.5 4241.6 4256.8 4280.0 4281.3 4352.5 4951.4 4966.6 4980.1 4986.4 5018.5 4263.7 4270.6 4275.7 4301.4 4310.7 4358.2 4403.8 4455.4 4455.6 4460.6 4621.6 4659.7 4662.2 4675.6 4730.3 4974.3 4979.3 4986.4 4991.4 5030.0 4579.0 4671.1 4680.6 4683.1 4729.5 4768.0 4815.3 4842.4 4862.6 4942.4 4949.0 4960.7 4967.7 4971.3 5045.0 4815.0 4870.9 4879.2 4880.1 4920.2 4688.5 4740.4 4791.0 4826.4 4840.7 4788.7 4790.3 4792.7 4796.0 4826.8 4911.9 4929.6 4929.8 4931.3 4974.5 4664.8 4722.3 4740.7 4756.7 4810.3 09:40:24 INFO - PROCESS | 20690 | 09:40:24 INFO - PROCESS | 20690 | [#1] ext.html Cycles:180 Average:43823.19 Median:34714.48 stddev:73605.73 (212.0%) stddev-sans-first:73740.50 09:40:24 INFO - PROCESS | 20690 | Values: 550.2 565.4 566.8 569.5 578.2 27244.9 30067.0 40334.8 41979.6 42024.2 38863.6 39204.8 39219.8 39247.4 39252.6 7564.7 7713.4 7715.6 7716.5 7720.7 7450.4 7653.2 9750.2 10164.6 10165.6 10077.4 10123.0 10138.0 10139.7 10142.7 9899.5 9938.5 9958.1 9959.7 9967.4 9875.3 9944.2 9950.2 9952.0 9952.4 36246.1 36326.5 36512.6 36555.0 36690.3 2923.9 3022.8 3051.4 3082.3 3248.6 27668.6 27710.3 27911.7 28576.0 29177.1 3411.2 3433.7 3482.6 3608.5 3628.2 233780.0 234534.0 236434.0 236526.8 237015.0 51099.5 51445.7 51521.7 51553.0 51553.0 53574.5 53639.0 53685.5 53707.5 53716.0 14544.9 14824.3 14843.6 14847.1 14848.4 9247.3 9452.5 11460.8 11529.5 11543.7 16154.0 16530.0 16588.5 16902.6 17125.7 5846.8 5961.0 5989.8 6017.7 6149.4 780.8 838.5 904.5 918.2 920.4 25208.4 27110.7 27239.9 27297.5 27613.3 934.4 946.3 954.6 971.6 1033.3 14035.9 14287.9 14306.3 14705.9 14726.7 309201.0 309587.0 310793.0 311657.0 311924.0 46483.8 46503.0 46523.3 46666.8 46685.8 996.3 1096.4 1098.2 1169.8 1189.9 25313.0 28134.3 28268.7 30831.5 31145.8 44837.1 45386.1 45638.1 45766.0 45835.5 290545.0 292964.0 293290.0 293920.0 294405.0 21770.8 22232.9 23787.8 24493.5 34986.0 39191.8 40699.8 40898.8 44076.0 44161.0 33862.3 34628.8 34931.3 34947.7 35382.5 34131.8 34674.5 34754.5 35126.0 35396.8 32343.3 32371.5 33526.7 33550.7 34902.0 29340.3 31579.4 31615.0 31637.8 31842.4 24242.7 24741.6 24744.0 24744.4 24906.0 09:40:24 INFO - PROCESS | 20690 | 09:40:24 INFO - PROCESS | 20690 | [#2] jquery.html Cycles:180 Average:22052.63 Median:350414.00 stddev:55668.25 (15.9%) stddev-sans-first:55800.54 09:40:24 INFO - PROCESS | 20690 | Values: 340.3 348.5 354.7 357.8 366.9 12707.7 13276.6 15545.7 16344.8 16828.7 15182.8 15581.8 15843.5 16913.4 17054.1 3957.4 4813.5 5032.8 5041.2 5041.8 4952.9 5018.6 5030.4 5031.4 5041.8 5002.2 5002.3 5005.1 5006.2 5007.8 4760.4 4919.2 4931.6 4940.6 4942.1 4393.1 4400.1 4402.1 4403.3 4403.6 20381.8 20405.8 20549.3 20668.5 20863.9 1842.0 1915.3 2039.2 2107.9 2341.9 12061.3 13155.7 13530.6 13563.1 13797.7 1646.4 1685.4 1692.2 1696.1 1728.8 66004.3 67505.3 67812.3 68276.7 69559.3 8877.5 9022.7 9073.2 9276.9 9533.0 10687.9 12600.4 12601.9 12602.6 12624.1 6234.9 6827.9 7221.6 7288.2 7375.7 6933.5 7001.1 7224.1 7264.0 7265.6 5904.9 6031.1 6038.7 6068.8 6098.3 1674.4 1682.5 1686.2 1693.9 1702.5 872.5 875.2 875.6 909.6 957.4 16557.3 16845.8 17598.0 17694.7 18092.2 848.8 856.6 868.5 876.1 881.8 9459.4 10077.7 10216.3 10229.3 10232.5 314585.0 323651.0 347662.0 350107.0 350721.0 60964.4 64842.0 64907.5 65020.3 67790.3 874.8 875.4 904.7 906.5 906.7 15233.7 15285.1 15818.2 15831.4 16080.6 33748.3 33880.3 34102.0 34655.5 34871.7 31769.4 34562.1 40368.4 41926.4 44619.0 6865.8 7177.3 7205.6 7231.4 7411.4 10736.8 11692.9 12061.0 12621.6 12655.8 9902.9 10213.9 10375.8 10506.9 10896.9 10086.9 10387.2 10398.3 10432.5 10980.7 10441.6 10523.7 10724.5 10830.9 10832.5 7481.3 7597.6 7705.2 7765.9 7801.8 10698.3 10721.8 10794.4 10855.5 11083.3 09:40:24 INFO - PROCESS | 20690 | 09:40:24 INFO - PROCESS | 20690 | [#3] mootools.html Cycles:180 Average:4719.20 Median:3142.29 stddev:2589.36 (82.4%) stddev-sans-first:2583.97 09:40:24 INFO - PROCESS | 20690 | Values: 1312.0 1358.2 1415.5 1609.6 1655.3 6439.6 6669.0 6704.1 7069.0 7069.5 6944.8 7201.9 7206.5 7376.2 7378.7 2094.3 2136.7 2138.1 2138.4 2138.5 1817.8 1911.4 2081.0 2111.1 2132.9 2016.6 2094.8 2101.6 2103.0 2104.2 2083.9 2086.9 2093.0 2101.3 2113.9 2042.0 2094.9 2095.0 2097.1 2097.7 7198.5 7244.2 7255.4 7260.8 7263.7 4045.5 4249.5 4349.9 4360.6 4362.4 2542.3 2585.8 2595.1 2606.2 2613.4 761.3 810.8 845.1 846.2 849.8 9652.5 9652.6 9667.0 9680.6 9685.2 3561.6 3800.3 3902.3 3911.5 3953.3 8385.7 8388.1 8388.2 8396.3 8407.3 4384.2 4390.1 4392.9 4394.4 4394.5 3847.8 4032.8 4034.1 4044.4 4045.0 3305.7 3321.1 3396.3 3404.2 3404.8 948.3 997.0 1056.2 1086.5 1086.6 564.6 724.5 850.4 853.5 855.6 4964.0 4979.5 5041.4 5050.4 5162.1 822.2 872.9 883.3 886.8 907.6 3312.8 3346.2 3371.3 3398.3 3500.1 8431.3 8799.4 8826.6 8847.4 8862.8 8777.0 8779.5 8780.9 8783.0 8807.8 6783.1 6873.9 6880.5 6891.1 6894.7 4787.7 4811.5 4816.1 4893.7 5028.1 7964.5 7991.7 8000.2 8006.1 8014.1 7869.6 8027.7 8056.0 8077.5 8166.2 6075.3 6154.8 6157.5 6164.4 6169.8 6686.1 6713.2 6870.0 6905.8 6914.9 4940.5 6077.8 6092.2 6134.8 6281.2 5888.1 5954.7 5954.9 6088.5 6134.6 5581.4 5720.0 5759.0 5761.5 5766.7 3843.3 4106.6 4152.5 4236.8 4348.3 4170.5 4181.9 4268.7 4340.7 4500.1 09:40:24 INFO - PROCESS | 20690 | 09:40:24 INFO - PROCESS | 20690 | [#4] prototype.html Cycles:180 Average:4087.72 Median:4695.98 stddev:1209.38 (25.8%) stddev-sans-first:1178.25 09:40:24 INFO - PROCESS | 20690 | Values: 265.5 265.8 268.1 271.1 276.4 4718.6 4768.3 4785.4 4792.6 4803.3 4706.7 4711.6 4712.3 4728.3 4731.6 3493.8 3597.6 3705.5 3706.7 3707.5 3536.9 3640.8 3658.8 3660.4 3667.8 3623.8 3631.5 3632.2 3633.2 3641.0 3474.8 3632.2 3642.7 3644.7 3651.7 3105.4 3114.6 3177.3 3215.2 3217.6 4567.5 4586.3 4587.2 4595.8 4598.8 4132.2 4149.6 4154.9 4166.8 4187.5 4769.9 4840.5 4884.6 4886.2 4890.4 3443.5 3449.6 3454.2 3459.0 3472.6 5157.1 5163.7 5165.1 5168.4 5173.9 3425.2 3523.6 3539.3 3540.4 3602.5 3624.8 3644.9 3647.4 3651.1 3652.5 4122.8 4150.1 4163.3 4171.6 4175.8 4945.8 4954.2 4967.8 4970.4 4972.0 1184.8 1227.5 1229.6 1235.5 1238.5 793.5 815.6 816.8 825.3 826.9 4239.8 4271.4 4279.3 4294.7 4297.5 4912.6 4993.8 5056.3 5133.4 5147.4 4384.1 4391.6 4398.3 4406.6 4414.7 2577.0 2600.3 2612.8 2619.3 2642.6 4587.8 4686.7 4694.6 4707.6 4719.4 5021.6 5036.6 5049.9 5052.0 5075.7 4682.7 4697.4 4697.9 4699.5 4707.4 4820.2 5147.2 5164.0 5172.3 5182.3 5061.4 5074.6 5077.6 5082.9 5083.8 4639.5 4871.8 4881.4 4886.1 4894.4 3504.8 3541.1 3544.7 3551.3 3552.6 5152.0 5155.6 5159.6 5164.8 5170.7 4829.2 4983.8 4988.8 5033.4 5044.2 4905.0 4969.9 4998.2 5009.0 5014.3 4886.1 4908.4 4910.0 4916.0 4937.6 4914.5 5013.7 5031.2 5036.4 5055.3 4674.4 4758.0 4824.5 4902.1 4954.0 09:40:24 INFO - PROCESS | 20690 | 09:40:24 INFO - PROCESS | 20690 | [#5] yui.html Cycles:180 Average:13824.56 Median:578.54 stddev:17955.77 (3103.6%) stddev-sans-first:17978.80 09:40:24 INFO - PROCESS | 20690 | Values: 629.8 654.5 668.4 669.2 686.1 11858.6 12713.7 12997.5 13124.5 13138.3 11995.3 12145.6 12150.6 12176.2 12181.2 609.9 632.2 750.9 766.3 768.2 750.9 776.5 786.3 788.5 789.2 816.0 817.2 818.1 818.5 818.9 636.5 657.6 803.5 803.8 804.6 562.8 578.3 586.1 586.3 586.5 12566.7 12619.4 12646.2 12649.6 12667.6 11948.8 12116.3 12434.8 12469.2 12635.3 10610.9 10664.4 11031.0 11047.6 11452.0 4007.8 4023.8 4028.7 4100.8 4146.9 46388.0 47162.0 47392.0 47809.0 48373.8 9852.8 10053.7 10057.2 10093.5 10230.3 17812.6 17900.4 17946.6 18039.3 18071.3 6576.6 6653.7 6662.1 6712.7 6831.1 3521.5 3731.6 3737.6 3745.4 3771.3 2571.7 2644.4 2659.0 2663.5 2665.3 438.5 490.3 511.9 519.8 525.1 485.3 565.1 566.3 603.7 608.3 7316.2 7335.7 7736.6 7967.4 7980.7 572.3 573.7 578.8 591.2 594.4 3523.3 3829.8 3847.3 3871.7 3981.8 68573.7 68918.3 69039.0 69411.7 69749.0 38307.2 54450.2 60289.4 61637.4 61879.6 55878.0 56177.0 56435.0 56917.4 58728.4 6863.6 7306.0 7370.9 7457.3 7659.5 24894.1 26512.5 34309.0 35467.5 35526.5 42460.8 44238.6 46919.5 47294.0 48019.3 8674.6 8822.6 8925.4 9145.2 9162.5 9724.2 10222.9 10421.6 10427.0 10484.5 8220.0 8300.6 8403.3 8620.3 8624.7 9357.0 9365.6 9436.5 9552.7 9582.2 7887.2 8168.2 8179.2 8359.0 8488.5 7634.6 7721.5 7873.6 8083.7 8167.7 7766.3 7857.3 8038.3 8134.6 8182.1 09:40:24 INFO - PROCESS | 20690 | -------- Summary: end -------- 09:40:24 INFO - PROCESS | 20690 | 09:40:25 INFO - TEST-INFO | 20690: exit 0 09:40:25 INFO - TEST-OK | dromaeo_css | took 1121572ms 09:40:25 INFO - TEST-START | kraken 09:40:25 INFO - operating with platform_type : linux_ 09:40:25 INFO - Initialising browser for kraken test... 09:40:25 INFO - TEST-INFO | started process 20992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW3HC3o/profile http://localhost:41045/getInfo.html) 09:40:29 INFO - PROCESS | 20992 | __metrics Screen width/height:1600/1200 09:40:29 INFO - PROCESS | 20992 | colorDepth:24 09:40:29 INFO - PROCESS | 20992 | Browser inner width/height: 1024/697 09:40:29 INFO - PROCESS | 20992 | __metrics 09:40:30 INFO - PROCESS | 20992 | 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" 09:40:30 INFO - PROCESS | 20992 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:30 INFO - PROCESS | 20992 | console.error: PushService: 09:40:30 INFO - PROCESS | 20992 | stateChangeProcessEnqueue: Error transitioning state 09:40:30 INFO - PROCESS | 20992 | UnknownError 09:40:31 INFO - TEST-INFO | 20992: exit 0 09:40:31 INFO - Browser initialized. 09:40:31 INFO - Running cycle 1/1 for kraken test... 09:40:31 INFO - TEST-INFO | started process 21075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW3HC3o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:43 INFO - PROCESS | 21075 | RSS: Main: 177254400 09:40:43 INFO - PROCESS | 21075 | 09:40:46 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41045/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:47 INFO - PROCESS | 21075 | RSS: Main: 235651072 09:40:47 INFO - PROCESS | 21075 | 09:40:50 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41045/tests/kraken/driver.html?testName=audio-dft) 09:40:50 INFO - PROCESS | 21075 | RSS: Main: 218021888 09:40:50 INFO - PROCESS | 21075 | 09:40:54 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41045/tests/kraken/driver.html?testName=audio-fft) 09:40:54 INFO - PROCESS | 21075 | RSS: Main: 299311104 09:40:54 INFO - PROCESS | 21075 | 09:40:56 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41045/tests/kraken/driver.html?testName=audio-oscillator) 09:40:57 INFO - PROCESS | 21075 | RSS: Main: 209674240 09:40:57 INFO - PROCESS | 21075 | 09:40:59 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41045/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:00 INFO - PROCESS | 21075 | RSS: Main: 214839296 09:41:00 INFO - PROCESS | 21075 | 09:41:03 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41045/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:04 INFO - PROCESS | 21075 | RSS: Main: 254124032 09:41:04 INFO - PROCESS | 21075 | 09:41:07 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41045/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:08 INFO - PROCESS | 21075 | RSS: Main: 253546496 09:41:08 INFO - PROCESS | 21075 | 09:41:11 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41045/tests/kraken/driver.html?testName=json-parse-financial) 09:41:11 INFO - PROCESS | 21075 | RSS: Main: 252461056 09:41:11 INFO - PROCESS | 21075 | 09:41:13 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41045/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:14 INFO - PROCESS | 21075 | RSS: Main: 215064576 09:41:14 INFO - PROCESS | 21075 | 09:41:15 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41045/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:16 INFO - PROCESS | 21075 | RSS: Main: 223277056 09:41:16 INFO - PROCESS | 21075 | 09:41:18 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41045/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:19 INFO - PROCESS | 21075 | RSS: Main: 230658048 09:41:19 INFO - PROCESS | 21075 | 09:41:22 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:23 INFO - PROCESS | 21075 | RSS: Main: 240762880 09:41:23 INFO - PROCESS | 21075 | 09:41:26 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:26 INFO - PROCESS | 21075 | RSS: Main: 237264896 09:41:26 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | Cycle 1(1): loaded http://localhost:41045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41045/tests/kraken/driver.html?testName=ai-astar) 09:41:28 INFO - PROCESS | 21075 | RSS: Main: 287891456 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | __start_tp_report 09:41:28 INFO - PROCESS | 21075 | _x_x_mozilla_page_load 09:41:28 INFO - PROCESS | 21075 | _x_x_mozilla_page_load_details 09:41:28 INFO - PROCESS | 21075 | |i|pagename|runs| 09:41:28 INFO - PROCESS | 21075 | |0;ai-astar;108;116;115;119;117;118;115;118;116;116 09:41:28 INFO - PROCESS | 21075 | |1;audio-beat-detection;162;133;128;158;135;134;137;133;158;129 09:41:28 INFO - PROCESS | 21075 | |2;audio-dft;161;161;161;162;164;161;161;162;162;161 09:41:28 INFO - PROCESS | 21075 | |3;audio-fft;75;80;76;119;77;77;77;79;91;76 09:41:28 INFO - PROCESS | 21075 | |4;audio-oscillator;84;85;112;84;83;83;100;84;84;106 09:41:28 INFO - PROCESS | 21075 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;119;117;117 09:41:28 INFO - PROCESS | 21075 | |6;imaging-darkroom;147;146;147;146;146;146;146;147;146;146 09:41:28 INFO - PROCESS | 21075 | |7;imaging-desaturate;96;95;96;96;95;95;95;96;96;95 09:41:28 INFO - PROCESS | 21075 | |8;json-parse-financial;65;65;64;64;66;66;65;65;65;65 09:41:28 INFO - PROCESS | 21075 | |9;json-stringify-tinderbox;66;67;67;67;67;67;67;67;66;67 09:41:28 INFO - PROCESS | 21075 | |10;stanford-crypto-aes;86;84;86;86;95;86;91;100;85;84 09:41:28 INFO - PROCESS | 21075 | |11;stanford-crypto-ccm;154;144;155;143;154;146;155;153;200;155 09:41:28 INFO - PROCESS | 21075 | |12;stanford-crypto-pbkdf2;189;186;189;182;186;182;182;182;181;180 09:41:28 INFO - PROCESS | 21075 | |13;stanford-crypto-sha256-iterative;70;71;70;70;76;74;69;71;69;73 09:41:28 INFO - PROCESS | 21075 | __end_tp_report 09:41:28 INFO - PROCESS | 21075 | __start_cc_report 09:41:28 INFO - PROCESS | 21075 | _x_x_mozilla_cycle_collect,1967 09:41:28 INFO - PROCESS | 21075 | __end_cc_report 09:41:28 INFO - PROCESS | 21075 | __startTimestamp1480009288908__endTimestamp 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | ------- Summary: start ------- 09:41:28 INFO - PROCESS | 21075 | Number of tests: 14 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.50 stddev:3.05 (2.6%) stddev-sans-first:1.41 09:41:28 INFO - PROCESS | 21075 | Values: 108.0 116.0 115.0 119.0 117.0 118.0 115.0 118.0 116.0 116.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:136.00 stddev:13.17 (9.7%) stddev-sans-first:11.49 09:41:28 INFO - PROCESS | 21075 | Values: 162.0 133.0 128.0 158.0 135.0 134.0 137.0 133.0 158.0 129.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.00 09:41:28 INFO - PROCESS | 21075 | Values: 161.0 161.0 161.0 162.0 164.0 161.0 161.0 162.0 162.0 161.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:13.56 (17.6%) stddev-sans-first:14.09 09:41:28 INFO - PROCESS | 21075 | Values: 75.0 80.0 76.0 119.0 77.0 77.0 77.0 79.0 91.0 76.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.00 stddev:11.08 (13.2%) stddev-sans-first:11.50 09:41:28 INFO - PROCESS | 21075 | Values: 84.0 85.0 112.0 84.0 83.0 83.0 100.0 84.0 84.0 106.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 09:41:28 INFO - PROCESS | 21075 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 119.0 117.0 117.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 09:41:28 INFO - PROCESS | 21075 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:41:28 INFO - PROCESS | 21075 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 09:41:28 INFO - PROCESS | 21075 | Values: 65.0 65.0 64.0 64.0 66.0 66.0 65.0 65.0 65.0 65.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 09:41:28 INFO - PROCESS | 21075 | Values: 66.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:86.00 stddev:5.36 (6.2%) stddev-sans-first:5.61 09:41:28 INFO - PROCESS | 21075 | Values: 86.0 84.0 86.0 86.0 95.0 86.0 91.0 100.0 85.0 84.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#11] stanford-crypto-ccm Cycles:10 Average:155.90 Median:154.50 stddev:16.22 (10.5%) stddev-sans-first:17.19 09:41:28 INFO - PROCESS | 21075 | Values: 154.0 144.0 155.0 143.0 154.0 146.0 155.0 153.0 200.0 155.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:184.00 stddev:3.31 (1.8%) stddev-sans-first:2.96 09:41:28 INFO - PROCESS | 21075 | Values: 189.0 186.0 189.0 182.0 186.0 182.0 182.0 182.0 181.0 180.0 09:41:28 INFO - PROCESS | 21075 | 09:41:28 INFO - PROCESS | 21075 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:2.31 (3.3%) stddev-sans-first:2.40 09:41:28 INFO - PROCESS | 21075 | Values: 70.0 71.0 70.0 70.0 76.0 74.0 69.0 71.0 69.0 73.0 09:41:28 INFO - PROCESS | 21075 | -------- Summary: end -------- 09:41:28 INFO - PROCESS | 21075 | 09:41:30 INFO - TEST-INFO | 21075: exit 0 09:41:30 INFO - TEST-OK | kraken | took 64297ms 09:41:30 INFO - SUITE-END | took 1185s 09:41:30 INFO - Completed test suite (00:19:46) 09:41:30 INFO - javascript benchmark 09:41:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.475512519933, 2588.352911772057, 2603.362176266815, 2619.5022945640326, 2627.448235870467, 4535.569120933506, 4619.7921093550785, 4624.028953919673, 4636.09596128755, 4638.8840278993, 4648.65135114866, 4675.0, 4691.460482044566, 4735.5974742146955, 4823.324734537159, 4243.469566304212, 4274.123804620045, 4309.741415515064, 4342.913141737179, 4426.092651006536, 3951.269015232177, 4272.87181384559, 4396.494403143632, 4436.979494716217, 4470.843520476784, 4190.895227619334, 4237.618614324695, 4381.408509851193, 4417.9116417671785, 4448.0436706108185, 4280.443542339507, 4290.635295999844, 4298.161858437606, 4301.161273551658, 4301.268784306675, 4265.722728022669, 4279.465066866642, 4280.571942805695, 4282.785860706983, 4284.67864910133, 4608.0, 4613.238815595423, 4613.769311534444, 4618.399608050931, 4631.513691062457, 4938.654294199408, 4982.57648099912, 5063.873403164914, 5063.873403164914, 5065.493450654905, 5013.047520971004, 5027.245913113025, 5028.7737051832755, 5069.518395752398, 5077.466865979093, 4643.976780116078, 4681.204195286809, 4694.460137084279, 4695.647826413033, 4737.976310118427, 4980.0, 5037.244413338029, 5039.319691841554, 5144.6655967362, 5183.533481986639, 4874.829380971649, 4875.049365373789, 4911.50884911506, 4945.901081978341, 4994.600431965434, 5010.69935803853, 5023.899522009539, 5025.3718285214345, 5025.422076461254, 5066.544011039025, 4820.421549414093, 4974.0, 4977.800887964513, 4980.526849949249, 5025.974870125626, 4846.321514987904, 4913.213885778258, 4925.38432695913, 4942.4316203637045, 4965.428975667773, 4221.767802770815, 4221.87334379963, 4223.239816832938, 4259.957400425956, 4263.680223983151, 3672.6878215351994, 3703.9074023149637, 3704.129529560551, 3734.5705243896755, 3741.5323084614424, 4241.575842415734, 4256.8297268109545, 4279.957200428018, 4281.336392859112, 4352.477702675636, 4951.3810773653295, 4966.553010229097, 4980.103581355391, 4986.376702912136, 5018.473060328686, 4263.658907287409, 4270.615644592001, 4275.679324050709, 4301.44081269433, 4310.655147588185, 4358.21552120615, 4403.823847046082, 4455.398521199597, 4455.6212721918355, 4460.576245256695, 4621.6302695784925, 4659.720416775004, 4662.207424737735, 4675.602573781131, 4730.337752714691, 4974.303597496281, 4979.253112033224, 4986.426560945392, 4991.376077990251, 5029.974850125873, 4579.0, 4671.135839869635, 4680.648951328596, 4683.110209060268, 4729.5034021427255, 4767.952320476889, 4815.30178124177, 4842.4189097308545, 4862.562369386772, 4942.406911170682, 4948.950510494993, 4960.677555958851, 4967.677100988569, 4971.304017437489, 5045.041442125985, 4814.975925120352, 4870.878228044186, 4879.194932836184, 4880.097182021337, 4920.21276595743, 4688.507706690748, 4740.431148262231, 4791.0, 4826.372571565815, 4840.661153719206, 4788.712677239377, 4790.281457781221, 4792.688475249098, 4795.976020119877, 4826.782794774173, 4911.901761964812, 4929.605631549539, 4929.802807887644, 4931.334269873521, 4974.527419895104, 4664.7667616618355, 4722.315264286728, 4740.715557066587, 4756.7145971241835, 4810.254410566367], "value": 4573.536521194671, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.2324257660563, 565.4430386069722, 566.8441178675863, 569.5159114752461, 578.2367275196737, 27244.86377568112, 30067.0, 40334.79832600833, 41979.58020419795, 42024.15951680965, 38863.61136388635, 39204.803975980154, 39219.80390098053, 39247.41128883062, 39252.60747392525, 7564.735234266802, 7713.42149338799, 7715.575643339614, 7716.459847810655, 7720.691172353099, 7450.366718828879, 7653.15815260321, 9750.219982401426, 10164.593416263378, 10165.593376264978, 10077.395356278646, 10123.0, 10138.03688649577, 10139.746506337327, 10142.695719128402, 9899.45552994585, 9938.503074846301, 9958.103770660602, 9959.651412200574, 9967.40195588267, 9875.308728389016, 9944.204463642964, 9950.154236889874, 9951.950240248825, 9952.402855828674, 36246.09384765402, 36326.45510317347, 36512.634873651186, 36555.0, 36690.266194676224, 2923.8976635817644, 3022.8488575571355, 3051.4354844353866, 3082.307891745279, 3248.561444205049, 27668.58497122545, 27710.307242319104, 27911.720882791116, 28576.0, 29177.124686259445, 3411.249525104473, 3433.725301975861, 3482.6343233960324, 3608.4767708682093, 3628.2380700053022, 233780.0, 234534.0, 236434.0, 236526.8173659138, 237015.0, 51099.48900510947, 51445.742771285906, 51521.7423912878, 51552.96894062098, 51553.0, 53574.46425535773, 53639.0, 53685.46314536883, 53707.46292537103, 53716.0, 14544.927275363556, 14824.258787060604, 14843.554693359001, 14847.109173449411, 14848.40606375733, 9247.306452016126, 9452.52737363129, 11460.770784584261, 11529.48117334722, 11543.711407214887, 16154.0, 16530.0, 16588.50234492967, 16902.57743556421, 17125.743113853303, 5846.795362162304, 5960.970195148997, 5989.760409583655, 6017.729202185912, 6149.41580549847, 780.8243145292264, 838.5304229631304, 904.4980036079908, 918.1919910478736, 920.3879420185501, 25208.36979075538, 27110.728892711213, 27239.86380068087, 27297.454050919267, 27613.30966725848, 934.4066517761271, 946.342292106979, 954.5895265036102, 971.6064993677572, 1033.3180101133366, 14035.929820351037, 14287.928560357132, 14306.28468576567, 14705.852941470663, 14726.705465890836, 309201.0, 309587.0, 310793.0, 311657.0, 311924.0, 46483.76758116255, 46503.0, 46523.30215046777, 46666.766666166455, 46685.76657116761, 996.2577879479834, 1096.4298564746287, 1098.214776434821, 1169.8245263210417, 1189.9226550274204, 25313.0, 28134.2966425841, 28268.717312826608, 30831.537526936667, 31145.84427077941, 44837.10325793531, 45386.09227815359, 45638.08723825571, 45766.0, 45835.54164458446, 290545.0, 292964.0, 293290.0, 293920.0, 294405.0, 21770.782292177508, 22232.888835556365, 23787.788648532918, 24493.51012979766, 34986.0, 39191.804040979616, 40699.79650101849, 40898.79550602228, 44076.0, 44161.0, 33862.32275354528, 34628.82685586556, 34931.301373972885, 34947.65052349546, 35382.46926296056, 34131.82934085314, 34674.47988280228, 34754.478682819274, 35126.0, 35396.82301588476, 32343.280522739245, 32371.51442728314, 33526.66473335236, 33550.66449335475, 34902.0, 29340.266493336985, 31579.36841263116, 31615.0, 31637.8418107908, 31842.363152737278, 24242.666254037176, 24741.62887556724, 24744.0, 24744.381390465383, 24906.0], "value": 17363.708282507418, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.290494319344, 348.52948519498676, 354.7499013195698, 357.79963220596454, 366.92844895245423, 12707.745845083116, 13276.601701948957, 15545.689086218268, 16344.75482867758, 16828.74756878648, 15182.772258416133, 15581.844181558181, 15843.524694259191, 16913.40803071893, 17054.062026588534, 3957.4261732048835, 4813.470518242999, 5032.84901452957, 5041.193409054552, 5041.798328066873, 4952.851414457572, 5018.623603229754, 5030.396352437694, 5031.4465408805, 5041.8487445376695, 5002.249662550628, 5002.349694539705, 5005.074061298653, 5006.1990081586955, 5007.774650140735, 4760.428748550179, 4919.2290775321035, 4931.556159945586, 4940.629452791055, 4942.085714142895, 4393.099414620027, 4400.075984043355, 4402.119576084764, 4403.3174857897075, 4403.647708183337, 20381.79618203814, 20405.79594204054, 20549.280775172945, 20668.48328791777, 20863.8956805215, 1841.9815801841944, 1915.348781414326, 2039.1843262694892, 2107.926222582202, 2341.934419838969, 12061.33662648554, 13155.73688526224, 13530.594082177451, 13563.050586458952, 13797.655058623615, 1646.3990643415186, 1685.3511398111693, 1692.1708362902211, 1696.1095424901903, 1728.7752592163065, 66004.3399566003, 67505.32494675039, 67812.32187678109, 68276.6586167071, 69559.30440695629, 8877.511736854534, 9022.729318120468, 9073.183413492818, 9276.90723092774, 9532.995177531851, 10687.946560267148, 12600.369981501071, 12601.873981260253, 12602.621921342374, 12624.116311858266, 6234.906476402857, 6827.897581536281, 7221.602811845294, 7288.161861385903, 7375.668094935633, 6933.514653974275, 7001.124859392576, 7224.096987876515, 7264.0, 7265.600391978492, 5904.911426328608, 6031.065184896348, 6038.698065096728, 6068.787592434332, 6098.32918378978, 1674.4390629139375, 1682.470021943084, 1686.249618919569, 1693.889897156681, 1702.4892532240278, 872.5462759365222, 875.1511034296722, 875.5578432891349, 909.5997760985277, 957.4111921168432, 16557.337706491846, 16845.83154168467, 17598.0, 17694.734578981326, 18092.185851636707, 848.7920459487465, 856.6230858422274, 868.4962721621445, 876.1282523888772, 881.8015946412006, 9459.38513996588, 10077.69766906994, 10216.284860059874, 10229.335093218917, 10232.53953572091, 314585.0, 323651.0, 347662.0, 350107.0, 350721.0, 60964.39035609676, 64842.0, 64907.512756433134, 65020.34979650238, 67790.32209677939, 874.7594411536751, 875.4090988582681, 904.6517090919912, 906.4606559097326, 906.7370462565914, 15233.734554324807, 15285.082895026335, 15818.209089545246, 15831.445899393466, 16080.597985050468, 33748.325033499685, 33880.32239355249, 34102.0, 34655.480167796995, 34871.65128348684, 31769.36461270808, 34562.13594660053, 40368.39447408233, 41926.371104432845, 44619.0, 6865.794026179223, 7177.282271772781, 7205.639718013974, 7231.4214862811905, 7411.370033547209, 10736.785264294827, 11692.883071169179, 12061.0, 12621.621351359474, 12655.810162847749, 9902.900970990486, 10213.948930255301, 10375.792484150124, 10506.947465262625, 10896.945515272373, 10086.940871208417, 10387.169026478015, 10398.324108933199, 10432.478376081013, 10980.670579882617, 10441.582336706446, 10523.737396459797, 10724.517396717323, 10830.891691083303, 10832.458377081271, 7481.289277518627, 7597.6201189941385, 7705.190954949874, 7765.92234077652, 7801.804954876174, 10698.251122421356, 10721.839172412576, 10794.352338859693, 10855.511501982272, 11083.334999900031], "value": 8025.470889550396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.0422091872933, 1358.1850889466318, 1415.5257988573828, 1609.5734630322975, 1655.3461382753806, 6439.581427207228, 6669.0, 6704.12846329977, 7068.964655176724, 7069.505134640577, 6944.791656250308, 7201.855962880739, 7206.4595155363295, 7376.151742549609, 7378.74174403896, 2094.2774742713777, 2136.6794980752934, 2138.0592539282743, 2138.3905586907736, 2138.4546940530145, 1817.800041995386, 1911.3596945023435, 2080.9791902080938, 2111.0711287033732, 2132.8826914519695, 2016.5563576013253, 2094.8428867834896, 2101.642720737478, 2102.98948505258, 2104.189886893542, 2083.9270625528034, 2086.906089225981, 2092.98490232238, 2101.338078505266, 2113.8520303578757, 2042.0, 2094.86383385081, 2094.979050209509, 2097.056324653897, 2097.674860396641, 7198.460115491359, 7244.203137654854, 7255.419566434673, 7260.818479538054, 7263.709451621929, 4045.4708957687767, 4249.532551419341, 4349.869503914888, 4360.607545320905, 4362.432883725127, 2542.2627438042946, 2585.767280944724, 2595.078747044791, 2606.2311618072713, 2613.4119823039855, 761.3034073822446, 810.8350703621345, 845.0873057098319, 846.2003406780594, 849.817289282801, 9652.517374131336, 9652.613895444174, 9666.95166524163, 9680.564374603231, 9685.225181985496, 3561.6082230954576, 3800.258949504875, 3902.3366027775346, 3911.4523966644692, 3953.3081710700512, 8385.706500272461, 8388.07731149573, 8388.203120703523, 8396.328293736486, 8407.285380742705, 4384.167008268419, 4390.100029493946, 4392.9121417572105, 4394.428724265889, 4394.494633117232, 3847.8076096195637, 4032.838686452568, 4034.092329225901, 4044.373122166069, 4045.0494133878515, 3305.743817349392, 3321.0534997525588, 3396.2698019925833, 3404.2340473393288, 3404.8297585120645, 948.3029972969862, 996.9900300997042, 1056.2078441169124, 1086.5490821309068, 1086.6088208245026, 564.6011013697599, 724.5109551053018, 850.4429598612918, 853.5220276645099, 855.6192494340083, 4964.0, 4979.502049794992, 5041.395032596039, 5050.419201791768, 5162.096633089194, 822.1572887789944, 872.9170728780756, 883.3154305413227, 886.7871710789364, 907.6051917415945, 3312.801231926092, 3346.1801858544327, 3371.292028674006, 3398.337324221753, 3500.054985153994, 8431.283340915968, 8799.428037177562, 8826.602802873886, 8847.42491738035, 8862.822743545094, 8777.0, 8779.517126557972, 8780.868286975701, 8783.0, 8807.823843523094, 6783.050372947791, 6873.896891546631, 6880.483963702743, 6891.104156459728, 6894.655267236719, 4787.712737235777, 4811.49479304668, 4816.123413784523, 4893.657443978887, 5028.069807085701, 7964.522128672298, 7991.720289790062, 8000.159983201913, 8006.079300880473, 8014.118446970712, 7869.6458659361615, 8027.719029834161, 8056.0, 8077.474964127313, 8166.183381661786, 6075.301340345917, 6154.753809847735, 6157.476614487639, 6164.4143806338325, 6169.784057557964, 6686.097376854257, 6713.160854893138, 6870.038194652652, 6905.827354316182, 6914.9308506914285, 4940.481249468754, 6077.817665470043, 6092.238470191226, 6134.8159555213415, 6281.246250449975, 5888.146218798336, 5954.7320370582565, 5954.880902382015, 6088.452039316483, 6134.570580059353, 5581.358143813513, 5719.971400142973, 5758.971205144115, 5761.5102716269585, 5766.70249193928, 3843.2889915365745, 4106.609872062149, 4152.522459917148, 4236.766977816126, 4348.326009468537, 4170.4995400552125, 4181.874543763692, 4268.679849011399, 4340.6744494163695, 4500.054988452331], "value": 3832.3458283778355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.5379639427397, 265.79799352492114, 268.1018587731101, 271.05132037867463, 276.3616046931589, 4718.622510199184, 4768.284757286408, 4785.377900872891, 4792.568668819806, 4803.327534145214, 4706.658602298346, 4711.623070154388, 4712.316714076457, 4728.267118596615, 4731.5978141857895, 3493.755437119403, 3597.6402359763947, 3705.4627079073516, 3706.7034637229026, 3707.461403517537, 3536.9389183245053, 3640.76335038223, 3658.7804731716183, 3660.3777357849094, 3667.8166091695443, 3623.7825730456125, 3631.5460567429072, 3632.237230181665, 3633.164372194397, 3641.035125691694, 3474.774139680913, 3632.1827588792576, 3642.7267954903223, 3644.669695561128, 3651.7443778935485, 3105.394448082625, 3114.6418161911442, 3177.3009937813645, 3215.2283451971357, 3217.581714377116, 4567.543245675439, 4586.266197408432, 4587.24310488769, 4595.7702114894455, 4598.839040633595, 4132.194222126686, 4149.613971966131, 4154.896127596804, 4166.7708276044805, 4187.51843537994, 4769.880752981203, 4840.5159484051665, 4884.6092312615265, 4886.218205087169, 4890.388701412324, 3443.500692399588, 3449.6029108211214, 3454.222799870034, 3458.9654103458893, 3472.618012018676, 5157.143428365785, 5163.66436181647, 5165.121929272071, 5168.3539557555305, 5173.896522069575, 3425.1779572902824, 3523.612402635708, 3539.292141571696, 3540.3627347077772, 3602.4776407420777, 3624.7643903146213, 3644.85420583179, 3647.361711700442, 3651.1419816343137, 3652.4521321801944, 4122.835086596562, 4150.149219410014, 4163.333866581333, 4171.561985991488, 4175.791210439465, 4945.7774400152075, 4954.20732682769, 4967.751612419437, 4970.403551573762, 4972.0, 1184.802325870341, 1227.4537830665267, 1229.5757963502576, 1235.4618499967419, 1238.4952282976228, 793.4604468961046, 815.6288888555812, 816.77946954322, 825.2572684583922, 826.8635675113538, 4239.788010599457, 4271.402003719481, 4279.336702811007, 4294.656427485794, 4297.484301883794, 4912.592829513585, 4993.825216117419, 5056.317397151411, 5133.435322114565, 5147.382314122329, 4384.12317536494, 4391.626711729475, 4398.274284743045, 4406.647468202536, 4414.690971631955, 2576.9871150644126, 2600.2849216465625, 2612.798112868064, 2619.3189770659383, 2642.5771876499666, 4587.79354929029, 4686.742229177428, 4694.577488026094, 4707.646926480459, 4719.362886010414, 5021.623378246646, 5036.61493089396, 5049.889024414623, 5051.974740126349, 5075.746212689351, 4682.695624784378, 4697.389339385858, 4697.8658780273145, 4699.475393454909, 4707.435107787019, 4820.228763397839, 5147.202183661539, 5163.974180129076, 5172.301739265151, 5182.274481572658, 5061.443241243386, 5074.5686616637995, 5077.619178561548, 5082.923756143735, 5083.771230294572, 4639.5360463954685, 4871.756412179448, 4881.438634557071, 4886.144924638103, 4894.412670479565, 3504.8247587621026, 3541.11472131967, 3544.663256990582, 3551.271989242251, 3552.609212986518, 5152.0, 5155.561777248826, 5159.613029022763, 5164.7934082636275, 5170.7156106413, 4829.203181475158, 4983.775730092227, 4988.750562471934, 5033.370828646419, 5044.243363495505, 4904.950950490449, 4969.937475947441, 4998.2002879539095, 5009.0, 5014.323066386137, 4886.144924638245, 4908.4355299139625, 4910.017996400806, 4915.975420122876, 4937.5556199942175, 4914.483979182134, 5013.699178049183, 5031.176306007387, 5036.445990941067, 5055.292259083658, 4674.392328997209, 4757.976210118927, 4824.517548245148, 4902.088185607688, 4953.975230123826], "value": 3694.359013997278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.7701339011262, 654.4764188649079, 668.3717305732611, 669.1869378704874, 686.1286166568461, 11858.584949526768, 12713.682157946056, 12997.545085921995, 13124.475020999173, 13138.343082845868, 11995.340256285901, 12145.635630931065, 12150.635480935563, 12176.208546444475, 12181.20822146562, 609.874975629997, 632.1813251838856, 750.9436792240576, 766.2835249042136, 768.2202564397113, 750.8723517002122, 776.510798197135, 786.34340325828, 788.4993029426327, 789.2305002622454, 815.9637260678963, 817.2113910076804, 818.1409520004001, 818.5497976113114, 818.9017317921857, 636.5353292096795, 657.5955787190891, 803.4897839871694, 803.8191406933394, 804.6057431858377, 562.8058319879635, 578.3175852494055, 586.1061880632028, 586.2876604925036, 586.4604563801313, 12566.74866502674, 12619.432125554373, 12646.241225526406, 12649.557265495756, 12667.556635517805, 11948.820767688492, 12116.273023618523, 12434.75130497385, 12469.189502682388, 12635.305058221795, 10610.893891061145, 10664.360138391721, 11031.0, 11047.558097676083, 11452.0, 4007.779572123532, 4023.7988100594853, 4028.738132021409, 4100.753954762724, 4146.854860079913, 46388.0, 47162.0, 47392.0, 47809.0, 48373.75813120912, 9852.753681158028, 10053.748656283651, 10057.245706572035, 10093.545790439448, 10230.335028223142, 17812.55468613295, 17900.373486927896, 17946.55133621644, 18039.278428862963, 18071.27714891416, 6576.638284894377, 6653.700583473756, 6662.100616416818, 6712.697928593225, 6831.11195544576, 3521.4893840393, 3731.552213734315, 3737.6075512071384, 3745.419459983707, 3771.264603402365, 2571.7171111177754, 2644.405008872988, 2659.002873922279, 2663.480621278832, 2665.3070201747687, 438.52639149718226, 490.291528740973, 511.93179554599004, 519.781394796249, 525.1440152551316, 485.34236110070344, 565.0507147991332, 566.2808233543377, 603.6800495737266, 608.3095686395884, 7316.158641756159, 7335.706571737071, 7736.613169341623, 7967.3626109911065, 7980.720674776355, 572.2602790762431, 573.6816067082809, 578.7598146769128, 591.2432086928738, 594.4471641373564, 3523.3481805865486, 3829.7702137871815, 3847.2882516734494, 3871.7483363581277, 3981.7810020448574, 68573.65713171502, 68918.31081689119, 69039.0, 69411.65294173497, 69749.0, 38307.23385532274, 54450.18324725132, 60289.39710602925, 61637.383626163166, 61879.57445106526, 55878.0, 56177.0, 56435.0, 56917.43082569121, 58728.41271587315, 6863.553868998499, 7306.0, 7370.926290737024, 7457.32884040439, 7659.502132361378, 24894.12870549522, 26512.469750604494, 34309.0, 35467.46798797968, 35526.46710299296, 42460.78769606132, 44238.557614423444, 46919.530804692884, 47294.0, 48019.279710805065, 8674.609642566225, 8822.64709411642, 8925.375223734276, 9145.222656074307, 9162.450252984841, 9724.222062235145, 10222.948885255526, 10421.583136674448, 10427.0, 10484.528196231035, 8220.0, 8300.626471808662, 8403.327733781405, 8620.310375169845, 8624.655013799378, 9356.95321523388, 9365.625374985197, 9436.480993545421, 9552.665656701982, 9582.233421326417, 7887.211278872067, 8168.224018718212, 8179.182081791773, 8358.958205208935, 8488.533130677872, 7634.580098094658, 7721.498102623312, 7873.606319684108, 8083.6766529338165, 8167.714130005421, 7766.339861111869, 7857.349956509197, 8038.31674307667, 8134.593270336341, 8182.099969003286], "value": 5809.04787440996, "unit": "score"}], "name": "dromaeo_css", "value": 6117.696746095099, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 115.0, 119.0, 117.0, 118.0, 115.0, 118.0, 116.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 128.0, 158.0, 135.0, 134.0, 137.0, 133.0, 158.0, 129.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 164.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 76.0, 119.0, 77.0, 77.0, 77.0, 79.0, 91.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 112.0, 84.0, 83.0, 83.0, 100.0, 84.0, 84.0, 106.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 119.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 86.0, 95.0, 86.0, 91.0, 100.0, 85.0, 84.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 144.0, 155.0, 143.0, 154.0, 146.0, 155.0, 153.0, 200.0, 155.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 186.0, 189.0, 182.0, 186.0, 182.0, 182.0, 182.0, 181.0, 180.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 70.0, 76.0, 74.0, 69.0, 71.0, 69.0, 73.0], "value": 71.3, "unit": "score"}], "name": "kraken", "value": 1581.2, "alertThreshold": 2.0}]} 09:41:30 INFO - Return code: 0 09:41:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:30 INFO - # TBPL SUCCESS # 09:41:30 INFO - Running post-action listener: _resource_record_post_action 09:41:30 INFO - [mozharness: 2016-11-24 17:41:30.694431Z] Finished run-tests step (success) 09:41:30 INFO - Running post-run listener: _resource_record_post_run 09:41:30 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 411164672; Read time: 16; Write time: 253704 09:41:30 INFO - TinderboxPrint: CPU usage
13.1% 09:41:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:41:30 INFO - TinderboxPrint: I/O write bytes / time
411,164,672 / 253,704 09:41:30 INFO - TinderboxPrint: CPU idle
8,337.5 (86.9%) 09:41:30 INFO - TinderboxPrint: CPU user
1,207.2 (12.6%) 09:41:30 INFO - TinderboxPrint: Swap in / out
0 / 0 09:41:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116215808; Read time: 0; Write time: 63960 09:41:30 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294948864; Read time: 0; Write time: 189744 09:41:31 INFO - Running post-run listener: _upload_blobber_files 09:41:31 INFO - Blob upload gear active. 09:41:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:31 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 09:41:31 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:41:31 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:41:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:41:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:32 INFO - (blobuploader) - INFO - Done attempting. 09:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:41:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:33 INFO - (blobuploader) - INFO - Done attempting. 09:41:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:37 INFO - (blobuploader) - INFO - Done attempting. 09:41:37 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:37 INFO - Return code: 0 09:41:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9bbc4ad478db222aa20a2e673978deabf7d8a889aec1fb0a578c7e33d4cfc7df4a455236b27f6ce0e5b26baabcaab105ef43a14f9d42c4589c75beff878ecaad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddc729a66608a7d383c8d27518a9c5f94347733a6c45e471927ccf39f27b35579d6917cf581ad1999a695aef0e33224f9130ccef5fe366251c54bb85bc5376cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0decda7a3e4a743dfe8d7b384032800c3661a70e07027fd80fd9d75420cb7d4ff51be055201772c02c9acbb4b11d03ccd9e67bafd93ca2fbe84feb59586fb6ee"} 09:41:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:37 INFO - Contents: 09:41:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9bbc4ad478db222aa20a2e673978deabf7d8a889aec1fb0a578c7e33d4cfc7df4a455236b27f6ce0e5b26baabcaab105ef43a14f9d42c4589c75beff878ecaad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddc729a66608a7d383c8d27518a9c5f94347733a6c45e471927ccf39f27b35579d6917cf581ad1999a695aef0e33224f9130ccef5fe366251c54bb85bc5376cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0decda7a3e4a743dfe8d7b384032800c3661a70e07027fd80fd9d75420cb7d4ff51be055201772c02c9acbb4b11d03ccd9e67bafd93ca2fbe84feb59586fb6ee"} 09:41:37 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:37 INFO - Copying logs to upload dir... 09:41:37 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.267100 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-24 09:41:37.431914) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 09:41:37.436309) ========= 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=0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442 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-Non-PGO/sha512/9bbc4ad478db222aa20a2e673978deabf7d8a889aec1fb0a578c7e33d4cfc7df4a455236b27f6ce0e5b26baabcaab105ef43a14f9d42c4589c75beff878ecaad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddc729a66608a7d383c8d27518a9c5f94347733a6c45e471927ccf39f27b35579d6917cf581ad1999a695aef0e33224f9130ccef5fe366251c54bb85bc5376cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0decda7a3e4a743dfe8d7b384032800c3661a70e07027fd80fd9d75420cb7d4ff51be055201772c02c9acbb4b11d03ccd9e67bafd93ca2fbe84feb59586fb6ee"} build_url:https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/TIzCbhZjSOi0TTZ5yKVPpA/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-Non-PGO/sha512/9bbc4ad478db222aa20a2e673978deabf7d8a889aec1fb0a578c7e33d4cfc7df4a455236b27f6ce0e5b26baabcaab105ef43a14f9d42c4589c75beff878ecaad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ddc729a66608a7d383c8d27518a9c5f94347733a6c45e471927ccf39f27b35579d6917cf581ad1999a695aef0e33224f9130ccef5fe366251c54bb85bc5376cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0decda7a3e4a743dfe8d7b384032800c3661a70e07027fd80fd9d75420cb7d4ff51be055201772c02c9acbb4b11d03ccd9e67bafd93ca2fbe84feb59586fb6ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 09:41:37.464150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:41:37.464473) ========= 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=0333a256a5e4f052382dd180000001b1-1480001100.853618-6996442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:41:37.544641) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 09:41:37.547002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 09:41:37.547287) ========= ========= Total master_lag: 0.17 =========