builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1477938812.09 results: success (0) buildid: 20161031070719 builduid: 2ec18ee4e29a4feea070544b8cc9b966 revision: fdea89bad933375fd650bc2cd8fee6dc860de9bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:32.085358) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:32.085804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:32.086129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:32.100767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:32.101075) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 11:33:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-10-31 11:33:32 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122446 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:32.237370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:32.237701) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017918 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:32.287186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 11:33:32.287544) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fdea89bad933375fd650bc2cd8fee6dc860de9bb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fdea89bad933375fd650bc2cd8fee6dc860de9bb --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=8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 11:33:32,521 truncating revision to first 12 chars 2016-10-31 11:33:32,521 Setting DEBUG logging. 2016-10-31 11:33:32,521 attempt 1/10 2016-10-31 11:33:32,521 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fdea89bad933?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 11:33:33,689 unpacking tar archive at: mozilla-inbound-fdea89bad933/testing/mozharness/ program finished with exit code 0 elapsedTime=1.540218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 11:33:33.843389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:33.843915) ========= script_repo_revision: fdea89bad933375fd650bc2cd8fee6dc860de9bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:33.844554) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:33.845042) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 11:33:33.856484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-31 11:33:33.856865) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:33:34 INFO - MultiFileLogger online at 20161031 11:33:34 in /builds/slave/test 11:33:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:33:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:33:34 INFO - {'append_to_log': False, 11:33:34 INFO - 'base_work_dir': '/builds/slave/test', 11:33:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:33:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:33:34 INFO - 'branch': 'Mozilla-Inbound', 11:33:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:33:34 INFO - 'config_files': ('talos/linux_config.py',), 11:33:34 INFO - 'default_actions': ('clobber', 11:33:34 INFO - 'read-buildbot-config', 11:33:34 INFO - 'download-and-extract', 11:33:34 INFO - 'populate-webroot', 11:33:34 INFO - 'create-virtualenv', 11:33:34 INFO - 'install', 11:33:34 INFO - 'run-tests'), 11:33:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:33:34 INFO - 'download_minidump_stackwalk': True, 11:33:34 INFO - 'download_symbols': 'ondemand', 11:33:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:33:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:33:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:33:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:33:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:33:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:33:34 INFO - 'installer_path': 'installer.exe', 11:33:34 INFO - 'log_level': 'info', 11:33:34 INFO - 'log_name': 'talos', 11:33:34 INFO - 'log_to_console': True, 11:33:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:33:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:33:34 INFO - 'opt_config_files': (), 11:33:34 INFO - 'pip_index': False, 11:33:34 INFO - 'sps_profile': False, 11:33:34 INFO - 'sps_profile_interval': 0, 11:33:34 INFO - 'suite': 'dromaeojs', 11:33:34 INFO - 'system_bits': '32', 11:33:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:33:34 INFO - 'title': 'talos-linux64-ix-001', 11:33:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:33:34 INFO - 'use_talos_json': True, 11:33:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:33:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:33:34 INFO - 'work_dir': 'build'} 11:33:34 INFO - [mozharness: 2016-10-31 18:33:34.186635Z] Running clobber step. 11:33:34 INFO - Running pre-action listener: _resource_record_pre_action 11:33:34 INFO - Running main action method: clobber 11:33:34 INFO - rmtree: /builds/slave/test/build 11:33:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:33:34 INFO - Running post-action listener: _resource_record_post_action 11:33:34 INFO - [mozharness: 2016-10-31 18:33:34.647592Z] Finished clobber step (success) 11:33:34 INFO - [mozharness: 2016-10-31 18:33:34.647692Z] Running read-buildbot-config step. 11:33:34 INFO - Running pre-action listener: _resource_record_pre_action 11:33:34 INFO - Running main action method: read_buildbot_config 11:33:34 INFO - Using buildbot properties: 11:33:34 INFO - { 11:33:34 INFO - "project": "", 11:33:34 INFO - "product": "firefox", 11:33:34 INFO - "script_repo_revision": "production", 11:33:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 11:33:34 INFO - "repository": "", 11:33:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 11:33:34 INFO - "buildid": "20161031070719", 11:33:34 INFO - "stage_platform": "linux64-pgo", 11:33:34 INFO - "basedir": "/builds/slave/test", 11:33:34 INFO - "buildnumber": 2710, 11:33:34 INFO - "platform": "ubuntu64_hw", 11:33:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:33:34 INFO - "slavebuilddir": "test", 11:33:34 INFO - "branch": "mozilla-inbound", 11:33:34 INFO - "revision": "fdea89bad933375fd650bc2cd8fee6dc860de9bb", 11:33:34 INFO - "slavename": "talos-linux64-ix-001", 11:33:34 INFO - "builduid": "2ec18ee4e29a4feea070544b8cc9b966", 11:33:34 INFO - "repo_path": "integration/mozilla-inbound" 11:33:34 INFO - } 11:33:34 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:33:34 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 11:33:34 INFO - Running post-action listener: _resource_record_post_action 11:33:34 INFO - [mozharness: 2016-10-31 18:33:34.650040Z] Finished read-buildbot-config step (success) 11:33:34 INFO - [mozharness: 2016-10-31 18:33:34.650128Z] Running download-and-extract step. 11:33:34 INFO - Running pre-action listener: _resource_record_pre_action 11:33:34 INFO - Running main action method: download_and_extract 11:33:34 INFO - mkdir: /builds/slave/test/build/tests 11:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:34 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:33:34 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:33:34 INFO - Downloaded 1361 bytes. 11:33:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:33:34 INFO - Using the following test package requirements: 11:33:34 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:33:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:33:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:34 INFO - u'jsshell-linux-x86_64.zip'], 11:33:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:33:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:33:34 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:33:34 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:33:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:33:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:33:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:33:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:33:34 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:33:34 INFO - Http code: 200 11:33:34 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 11:33:34 INFO - x-amz-cf-id: ckYkymuY0APm1vDAYjdORul5qgH-fh7Tw_-36mwQryBVFM-GEu8Opg== 11:33:34 INFO - x-amz-replication-status: COMPLETED 11:33:34 INFO - x-amz-version-id: J0mRHzdPechunDYoowHm1O49K14CWgwA 11:33:35 INFO - Expected file size: 22005986 11:33:35 INFO - Obtained file size: 22005986 11:33:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:33:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:33:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:33:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:33:39 INFO - Http code: 200 11:33:39 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 11:33:39 INFO - x-amz-cf-id: EZtX0LlAIFdbA_5UnzqQIGaqXc_lAgQXvs9-PCg7FjaLNe_1NqdLLQ== 11:33:39 INFO - x-amz-replication-status: COMPLETED 11:33:39 INFO - x-amz-version-id: J0mRHzdPechunDYoowHm1O49K14CWgwA 11:33:39 INFO - Expected file size: 22005986 11:33:39 INFO - Obtained file size: 22005986 11:33:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:33:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:33:43 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:33:43 INFO - Http code: 200 11:33:43 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 11:33:43 INFO - x-amz-cf-id: aWYQJ6GCr7qwHHGwaTGWiUmacOLoKMEoDDADBx6MnHRcBkjbbyupWA== 11:33:43 INFO - x-amz-replication-status: COMPLETED 11:33:43 INFO - x-amz-version-id: 8p9oyOlUI6gSaf9UzbnvgM74eZ65UuPJ 11:33:44 INFO - Expected file size: 14409038 11:33:44 INFO - Obtained file size: 14409038 11:33: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')]} 11:33:44 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:33:44 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:33:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:33:45 INFO - Downloaded 59645761 bytes. 11:33:45 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:33:45 INFO - mkdir: /builds/slave/test/properties 11:33:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:33:45 INFO - Writing to file /builds/slave/test/properties/build_url 11:33:45 INFO - Contents: 11:33:45 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:33:45 INFO - Running post-action listener: _resource_record_post_action 11:33:45 INFO - Running post-action listener: set_extra_try_arguments 11:33:45 INFO - [mozharness: 2016-10-31 18:33:45.406540Z] Finished download-and-extract step (success) 11:33:45 INFO - [mozharness: 2016-10-31 18:33:45.406767Z] Running populate-webroot step. 11:33:45 INFO - Running pre-action listener: _resource_record_pre_action 11:33:45 INFO - Running main action method: populate_webroot 11:33:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:33:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:33:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:33:45 INFO - '--tppagecycles', 11:33:45 INFO - '7'], 11:33:45 INFO - 'tests': ['tsvgm']}}, 11:33:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:33:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:33:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:33:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:33:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:45 INFO - 'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:45 INFO - 'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['damp', 'tps']}, 11:33:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:45 INFO - 'tests': ['damp', 'tps']}, 11:33:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['dromaeo_dom']}, 11:33:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:33:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['basic_compositor_video']}, 11:33:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:33:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['a11yr', 11:33:45 INFO - 'ts_paint', 11:33:45 INFO - 'tpaint', 11:33:45 INFO - 'sessionrestore', 11:33:45 INFO - 'sessionrestore_no_auto_restore', 11:33:45 INFO - 'tabpaint']}, 11:33:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:33:45 INFO - 'ts_paint', 11:33:45 INFO - 'tpaint', 11:33:45 INFO - 'sessionrestore', 11:33:45 INFO - 'sessionrestore_no_auto_restore', 11:33:45 INFO - 'tabpaint']}, 11:33:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:33:45 INFO - 'ts_paint', 11:33:45 INFO - 'tpaint', 11:33:45 INFO - 'sessionrestore', 11:33:45 INFO - 'sessionrestore_no_auto_restore', 11:33:45 INFO - 'tabpaint']}, 11:33:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:33:45 INFO - 'ts_paint', 11:33:45 INFO - 'tpaint', 11:33:45 INFO - 'sessionrestore', 11:33:45 INFO - 'sessionrestore_no_auto_restore', 11:33:45 INFO - 'tabpaint']}, 11:33:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['a11yr', 11:33:45 INFO - 'ts_paint', 11:33:45 INFO - 'tpaint', 11:33:45 INFO - 'sessionrestore', 11:33:45 INFO - 'sessionrestore_no_auto_restore', 11:33:45 INFO - 'tabpaint']}, 11:33:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['a11yr', 11:33:45 INFO - 'ts_paint', 11:33:45 INFO - 'tpaint', 11:33:45 INFO - 'sessionrestore', 11:33:45 INFO - 'sessionrestore_no_auto_restore', 11:33:45 INFO - 'tabpaint']}, 11:33:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['tsvgx', 11:33:45 INFO - 'tsvgr_opacity', 11:33:45 INFO - 'tart', 11:33:45 INFO - 'tscrollx', 11:33:45 INFO - 'cart']}, 11:33:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:33:45 INFO - 'tsvgr_opacity', 11:33:45 INFO - 'tart', 11:33:45 INFO - 'tscrollx', 11:33:45 INFO - 'cart']}, 11:33:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:45 INFO - 'talos_options': ['--disable-e10s'], 11:33:45 INFO - 'tests': ['tp5o']}, 11:33:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:45 INFO - 'tests': ['tp5o']}, 11:33:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:45 INFO - 'talos_options': ['--disable-e10s', 11:33:45 INFO - '--xperf_path', 11:33:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:45 INFO - 'tests': ['tp5n']}, 11:33:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:45 INFO - 'talos_options': ['--xperf_path', 11:33:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:45 INFO - 'tests': ['tp5n']}}, 11:33:45 INFO - 'talos.zip': {'path': '', 11:33:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:33:45 INFO - Running post-action listener: _resource_record_post_action 11:33:45 INFO - [mozharness: 2016-10-31 18:33:45.425480Z] Finished populate-webroot step (success) 11:33:45 INFO - [mozharness: 2016-10-31 18:33:45.425567Z] Running create-virtualenv step. 11:33:45 INFO - Running pre-action listener: _resource_record_pre_action 11:33:45 INFO - Running main action method: create_virtualenv 11:33:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:33:45 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 11:33:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:33:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:33:45 INFO - Using real prefix '/usr' 11:33:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:33:46 INFO - Installing distribute.............................................................................................................................................................................................done. 11:33:48 INFO - Installing pip.................done. 11:33:48 INFO - Return code: 0 11:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:33:48 INFO - Reading from file tmpfile_stdout 11:33:48 INFO - Output received: 11:33:48 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) 11:33:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:33:48 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')]} 11:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:48 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')]} 11:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:48 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 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:33:48 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 11:33:48 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 11:33:48 INFO - Using env: {'DISPLAY': ':0', 11:33:48 INFO - 'HOME': '/home/cltbld', 11:33:48 INFO - 'LANG': 'en_US.UTF-8', 11:33:48 INFO - 'LANGUAGE': 'en_US:en', 11:33:48 INFO - 'LOGNAME': 'cltbld', 11:33:48 INFO - 'MAIL': '/var/mail/cltbld', 11:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:48 INFO - 'MOZ_NO_REMOTE': '1', 11:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:48 INFO - 'NO_EM_RESTART': '1', 11:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:48 INFO - 'PWD': '/builds/slave/test', 11:33:48 INFO - 'SHELL': '/bin/bash', 11:33:48 INFO - 'SHLVL': '1', 11:33:48 INFO - 'TERM': 'linux', 11:33:48 INFO - 'TMOUT': '86400', 11:33:48 INFO - 'USER': 'cltbld', 11:33:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:48 INFO - '_': '/tools/buildbot/bin/python'} 11:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:48 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 11:33:48 INFO - Cleaning up... 11:33:48 INFO - Return code: 0 11:33:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:33:48 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')]} 11:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:48 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')]} 11:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:48 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 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:33:48 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 11:33:48 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 11:33:48 INFO - Using env: {'DISPLAY': ':0', 11:33:48 INFO - 'HOME': '/home/cltbld', 11:33:48 INFO - 'LANG': 'en_US.UTF-8', 11:33:48 INFO - 'LANGUAGE': 'en_US:en', 11:33:48 INFO - 'LOGNAME': 'cltbld', 11:33:48 INFO - 'MAIL': '/var/mail/cltbld', 11:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:48 INFO - 'MOZ_NO_REMOTE': '1', 11:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:48 INFO - 'NO_EM_RESTART': '1', 11:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:48 INFO - 'PWD': '/builds/slave/test', 11:33:48 INFO - 'SHELL': '/bin/bash', 11:33:48 INFO - 'SHLVL': '1', 11:33:48 INFO - 'TERM': 'linux', 11:33:48 INFO - 'TMOUT': '86400', 11:33:48 INFO - 'USER': 'cltbld', 11:33:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:48 INFO - '_': '/tools/buildbot/bin/python'} 11:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:48 INFO - Downloading/unpacking psutil>=3.1.1 11:33:48 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 11:33:48 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 11:33:48 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 11:33:48 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 11:33:48 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 11:33:48 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 11:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:33:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:50 INFO - Installing collected packages: psutil 11:33:50 INFO - Running setup.py install for psutil 11:33:50 INFO - building 'psutil._psutil_linux' extension 11:33:50 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 11:33:50 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 11:33:51 INFO - building 'psutil._psutil_posix' extension 11:33:51 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 11:33:51 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 11:33:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:51 INFO - Successfully installed psutil 11:33:51 INFO - Cleaning up... 11:33:51 INFO - Return code: 0 11:33:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:33: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')]} 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33: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')]} 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:51 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 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:33:51 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 11:33:51 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 11:33:51 INFO - Using env: {'DISPLAY': ':0', 11:33:51 INFO - 'HOME': '/home/cltbld', 11:33:51 INFO - 'LANG': 'en_US.UTF-8', 11:33:51 INFO - 'LANGUAGE': 'en_US:en', 11:33:51 INFO - 'LOGNAME': 'cltbld', 11:33:51 INFO - 'MAIL': '/var/mail/cltbld', 11:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:51 INFO - 'MOZ_NO_REMOTE': '1', 11:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:51 INFO - 'NO_EM_RESTART': '1', 11:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:51 INFO - 'PWD': '/builds/slave/test', 11:33:51 INFO - 'SHELL': '/bin/bash', 11:33:51 INFO - 'SHLVL': '1', 11:33:51 INFO - 'TERM': 'linux', 11:33:51 INFO - 'TMOUT': '86400', 11:33:51 INFO - 'USER': 'cltbld', 11:33:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:51 INFO - '_': '/tools/buildbot/bin/python'} 11:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:33:53 INFO - Installing collected packages: mozsystemmonitor 11:33:53 INFO - Running setup.py install for mozsystemmonitor 11:33:53 INFO - Successfully installed mozsystemmonitor 11:33:53 INFO - Cleaning up... 11:33:53 INFO - Return code: 0 11:33:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:33:53 INFO - Using env: {'DISPLAY': ':0', 11:33:53 INFO - 'HOME': '/home/cltbld', 11:33:53 INFO - 'LANG': 'en_US.UTF-8', 11:33:53 INFO - 'LANGUAGE': 'en_US:en', 11:33:53 INFO - 'LOGNAME': 'cltbld', 11:33:53 INFO - 'MAIL': '/var/mail/cltbld', 11:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:53 INFO - 'MOZ_NO_REMOTE': '1', 11:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:53 INFO - 'NO_EM_RESTART': '1', 11:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:53 INFO - 'PWD': '/builds/slave/test', 11:33:53 INFO - 'SHELL': '/bin/bash', 11:33:53 INFO - 'SHLVL': '1', 11:33:53 INFO - 'TERM': 'linux', 11:33:53 INFO - 'TMOUT': '86400', 11:33:53 INFO - 'USER': 'cltbld', 11:33:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:53 INFO - '_': '/tools/buildbot/bin/python'} 11:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:53 INFO - Downloading/unpacking jsonschema==2.5.1 11:33:53 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 11:33:53 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 11:33:53 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 11:33:53 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 11:33:53 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 11:33:53 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 11:33:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:33:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:33:56 INFO - warning: no files found matching '*.txt' 11:33:56 INFO - no previously-included directories found matching 'build' 11:33:56 INFO - no previously-included directories found matching 'dist' 11:33:56 INFO - no previously-included directories found matching '.git*' 11:33:56 INFO - Installing collected packages: jsonschema, functools32 11:33:56 INFO - Running setup.py install for functools32 11:33:56 INFO - warning: no files found matching '*.txt' 11:33:56 INFO - no previously-included directories found matching 'build' 11:33:56 INFO - no previously-included directories found matching 'dist' 11:33:56 INFO - no previously-included directories found matching '.git*' 11:33:56 INFO - Successfully installed jsonschema functools32 11:33:56 INFO - Cleaning up... 11:33:56 INFO - Return code: 0 11:33:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:33:56 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')]} 11:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:56 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')]} 11:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:56 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 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:33:56 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 11:33:56 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 11:33:56 INFO - Using env: {'DISPLAY': ':0', 11:33:56 INFO - 'HOME': '/home/cltbld', 11:33:56 INFO - 'LANG': 'en_US.UTF-8', 11:33:56 INFO - 'LANGUAGE': 'en_US:en', 11:33:56 INFO - 'LOGNAME': 'cltbld', 11:33:56 INFO - 'MAIL': '/var/mail/cltbld', 11:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:56 INFO - 'MOZ_NO_REMOTE': '1', 11:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:56 INFO - 'NO_EM_RESTART': '1', 11:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:56 INFO - 'PWD': '/builds/slave/test', 11:33:56 INFO - 'SHELL': '/bin/bash', 11:33:56 INFO - 'SHLVL': '1', 11:33:56 INFO - 'TERM': 'linux', 11:33:56 INFO - 'TMOUT': '86400', 11:33:56 INFO - 'USER': 'cltbld', 11:33:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:56 INFO - '_': '/tools/buildbot/bin/python'} 11:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:33:56 INFO - Cleaning up... 11:33:56 INFO - Return code: 0 11:33:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:33:56 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')]} 11:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:56 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')]} 11:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:56 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 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:33:56 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 11:33:56 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 11:33:56 INFO - Using env: {'DISPLAY': ':0', 11:33:56 INFO - 'HOME': '/home/cltbld', 11:33:56 INFO - 'LANG': 'en_US.UTF-8', 11:33:56 INFO - 'LANGUAGE': 'en_US:en', 11:33:56 INFO - 'LOGNAME': 'cltbld', 11:33:56 INFO - 'MAIL': '/var/mail/cltbld', 11:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:56 INFO - 'MOZ_NO_REMOTE': '1', 11:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:56 INFO - 'NO_EM_RESTART': '1', 11:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:56 INFO - 'PWD': '/builds/slave/test', 11:33:56 INFO - 'SHELL': '/bin/bash', 11:33:56 INFO - 'SHLVL': '1', 11:33:56 INFO - 'TERM': 'linux', 11:33:56 INFO - 'TMOUT': '86400', 11:33:56 INFO - 'USER': 'cltbld', 11:33:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:56 INFO - '_': '/tools/buildbot/bin/python'} 11:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:33:56 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 11:33:56 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 11:33:56 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 11:33:56 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 11:33:56 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 11:33:56 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 11:33:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:33:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:33:58 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 11:33:58 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 11:33:58 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 11:33:58 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 11:33:58 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 11:33:58 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 11:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:33:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:33:59 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 11:33:59 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 11:33:59 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 11:33:59 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 11:33:59 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 11:33:59 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 11:33:59 INFO - Downloading docopt-0.6.1.tar.gz 11:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:33:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:33:59 INFO - Running setup.py install for blobuploader 11:33:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:33:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:33:59 INFO - Running setup.py install for requests 11:33:59 INFO - Running setup.py install for docopt 11:33:59 INFO - Successfully installed blobuploader requests docopt 11:33:59 INFO - Cleaning up... 11:34:00 INFO - Return code: 0 11:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:00 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 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:34:00 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 11:34:00 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 11:34:00 INFO - Using env: {'DISPLAY': ':0', 11:34:00 INFO - 'HOME': '/home/cltbld', 11:34:00 INFO - 'LANG': 'en_US.UTF-8', 11:34:00 INFO - 'LANGUAGE': 'en_US:en', 11:34:00 INFO - 'LOGNAME': 'cltbld', 11:34:00 INFO - 'MAIL': '/var/mail/cltbld', 11:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:00 INFO - 'MOZ_NO_REMOTE': '1', 11:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:00 INFO - 'NO_EM_RESTART': '1', 11:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:00 INFO - 'PWD': '/builds/slave/test', 11:34:00 INFO - 'SHELL': '/bin/bash', 11:34:00 INFO - 'SHLVL': '1', 11:34:00 INFO - 'TERM': 'linux', 11:34:00 INFO - 'TMOUT': '86400', 11:34:00 INFO - 'USER': 'cltbld', 11:34:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:00 INFO - '_': '/tools/buildbot/bin/python'} 11:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:00 INFO - Running setup.py (path:/tmp/pip-5AyOSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:00 INFO - Running setup.py (path:/tmp/pip-0sg0mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:00 INFO - Running setup.py (path:/tmp/pip-GlNOWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:00 INFO - Running setup.py (path:/tmp/pip-ClAh0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:00 INFO - Running setup.py (path:/tmp/pip-di3j22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:00 INFO - Running setup.py (path:/tmp/pip-nInAK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:00 INFO - Running setup.py (path:/tmp/pip-NcqbFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:00 INFO - Running setup.py (path:/tmp/pip-l8362f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:00 INFO - Running setup.py (path:/tmp/pip-w0M5x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:00 INFO - Running setup.py (path:/tmp/pip-HvH2P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:00 INFO - Running setup.py (path:/tmp/pip-6YV7C6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:01 INFO - Running setup.py (path:/tmp/pip-PMIn4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:01 INFO - Running setup.py (path:/tmp/pip-fVhNfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:01 INFO - Running setup.py (path:/tmp/pip-bnb_8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:01 INFO - Running setup.py (path:/tmp/pip-lFDFWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:01 INFO - Running setup.py (path:/tmp/pip-ZZ4BdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:01 INFO - Running setup.py (path:/tmp/pip-7jO67Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:34:01 INFO - Running setup.py install for manifestparser 11:34:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:34:01 INFO - Running setup.py install for mozcrash 11:34:01 INFO - Running setup.py install for mozdebug 11:34:01 INFO - Running setup.py install for mozdevice 11:34:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:34:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:34:01 INFO - Running setup.py install for mozfile 11:34:02 INFO - Running setup.py install for mozhttpd 11:34:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Running setup.py install for mozinfo 11:34:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Running setup.py install for mozInstall 11:34:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Running setup.py install for mozleak 11:34:02 INFO - Running setup.py install for mozlog 11:34:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Running setup.py install for moznetwork 11:34:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Running setup.py install for mozprocess 11:34:02 INFO - Running setup.py install for mozprofile 11:34:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Running setup.py install for mozrunner 11:34:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:34:02 INFO - Running setup.py install for mozscreenshot 11:34:03 INFO - Running setup.py install for moztest 11:34:03 INFO - Running setup.py install for mozversion 11:34:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:34:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:34:03 INFO - Cleaning up... 11:34:03 INFO - Return code: 0 11:34:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34: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')]} 11:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34: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')]} 11:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:03 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 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:34:03 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 11:34:03 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 11:34:03 INFO - Using env: {'DISPLAY': ':0', 11:34:03 INFO - 'HOME': '/home/cltbld', 11:34:03 INFO - 'LANG': 'en_US.UTF-8', 11:34:03 INFO - 'LANGUAGE': 'en_US:en', 11:34:03 INFO - 'LOGNAME': 'cltbld', 11:34:03 INFO - 'MAIL': '/var/mail/cltbld', 11:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:03 INFO - 'MOZ_NO_REMOTE': '1', 11:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:03 INFO - 'NO_EM_RESTART': '1', 11:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:03 INFO - 'PWD': '/builds/slave/test', 11:34:03 INFO - 'SHELL': '/bin/bash', 11:34:03 INFO - 'SHLVL': '1', 11:34:03 INFO - 'TERM': 'linux', 11:34:03 INFO - 'TMOUT': '86400', 11:34:03 INFO - 'USER': 'cltbld', 11:34:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:03 INFO - '_': '/tools/buildbot/bin/python'} 11:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:03 INFO - Running setup.py (path:/tmp/pip-Dlv4mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:03 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)) 11:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:03 INFO - Running setup.py (path:/tmp/pip-wgF7rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:03 INFO - Running setup.py (path:/tmp/pip-HgqSqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:03 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)) 11:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:03 INFO - Running setup.py (path:/tmp/pip-xhEd89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:03 INFO - Running setup.py (path:/tmp/pip-mR4odr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:03 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)) 11:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:03 INFO - Running setup.py (path:/tmp/pip-aSBQjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:03 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)) 11:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:03 INFO - Running setup.py (path:/tmp/pip-3f6cBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:04 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)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:04 INFO - Running setup.py (path:/tmp/pip-IvOb_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:04 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)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:04 INFO - Running setup.py (path:/tmp/pip-chtaQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:04 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)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:04 INFO - Running setup.py (path:/tmp/pip-SYRS_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:04 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)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:04 INFO - Running setup.py (path:/tmp/pip-xaDuaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:04 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)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:04 INFO - Running setup.py (path:/tmp/pip-veRNHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:04 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)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:04 INFO - Running setup.py (path:/tmp/pip-ZEwNFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:04 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)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:04 INFO - Running setup.py (path:/tmp/pip-E7cicM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:04 INFO - Running setup.py (path:/tmp/pip-qoMj2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:04 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)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:04 INFO - Running setup.py (path:/tmp/pip-LmwhOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:04 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)) 11:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:04 INFO - Running setup.py (path:/tmp/pip-CByE91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:04 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)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:34:04 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)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:34:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:34:04 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 11:34:04 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 11:34:04 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 11:34:04 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 11:34:04 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 11:34:04 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 11:34:06 INFO - Downloading blessings-1.6.tar.gz 11:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:34:06 INFO - Installing collected packages: blessings 11:34:06 INFO - Running setup.py install for blessings 11:34:06 INFO - Successfully installed blessings 11:34:06 INFO - Cleaning up... 11:34:06 INFO - Return code: 0 11:34:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:07 INFO - Reading from file tmpfile_stdout 11:34:07 INFO - Current package versions: 11:34:07 INFO - argparse == 1.2.1 11:34:07 INFO - blessings == 1.6 11:34:07 INFO - blobuploader == 1.2.4 11:34:07 INFO - docopt == 0.6.1 11:34:07 INFO - functools32 == 3.2.3-2 11:34:07 INFO - jsonschema == 2.5.1 11:34:07 INFO - manifestparser == 1.1 11:34:07 INFO - mozInstall == 1.12 11:34:07 INFO - mozcrash == 0.17 11:34:07 INFO - mozdebug == 0.1 11:34:07 INFO - mozdevice == 0.48 11:34:07 INFO - mozfile == 1.2 11:34:07 INFO - mozhttpd == 0.7 11:34:07 INFO - mozinfo == 0.9 11:34:07 INFO - mozleak == 0.1 11:34:07 INFO - mozlog == 3.4 11:34:07 INFO - moznetwork == 0.27 11:34:07 INFO - mozprocess == 0.23 11:34:07 INFO - mozprofile == 0.28 11:34:07 INFO - mozrunner == 6.12 11:34:07 INFO - mozscreenshot == 0.1 11:34:07 INFO - mozsystemmonitor == 0.3 11:34:07 INFO - moztest == 0.7 11:34:07 INFO - mozversion == 1.4 11:34:07 INFO - psutil == 3.1.1 11:34:07 INFO - requests == 1.2.3 11:34:07 INFO - wsgiref == 0.1.2 11:34:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:07 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')]} 11:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:07 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')]} 11:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:07 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 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:34:07 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 11:34:07 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 11:34:07 INFO - Using env: {'DISPLAY': ':0', 11:34:07 INFO - 'HOME': '/home/cltbld', 11:34:07 INFO - 'LANG': 'en_US.UTF-8', 11:34:07 INFO - 'LANGUAGE': 'en_US:en', 11:34:07 INFO - 'LOGNAME': 'cltbld', 11:34:07 INFO - 'MAIL': '/var/mail/cltbld', 11:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:07 INFO - 'MOZ_NO_REMOTE': '1', 11:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:07 INFO - 'NO_EM_RESTART': '1', 11:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:07 INFO - 'PWD': '/builds/slave/test', 11:34:07 INFO - 'SHELL': '/bin/bash', 11:34:07 INFO - 'SHLVL': '1', 11:34:07 INFO - 'TERM': 'linux', 11:34:07 INFO - 'TMOUT': '86400', 11:34:07 INFO - 'USER': 'cltbld', 11:34:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:07 INFO - '_': '/tools/buildbot/bin/python'} 11:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:07 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)) 11:34:07 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)) 11:34:07 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)) 11:34:07 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)) 11:34:07 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)) 11:34:07 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)) 11:34:07 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)) 11:34:07 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)) 11:34:07 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)) 11:34:07 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)) 11:34:07 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)) 11:34:07 INFO - Cleaning up... 11:34:07 INFO - Return code: 0 11:34:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:34:07 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')]} 11:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:07 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')]} 11:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:07 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 0x7fafa9785f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', '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 11:34:07 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 11:34:07 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 11:34:07 INFO - Using env: {'DISPLAY': ':0', 11:34:07 INFO - 'HOME': '/home/cltbld', 11:34:07 INFO - 'LANG': 'en_US.UTF-8', 11:34:07 INFO - 'LANGUAGE': 'en_US:en', 11:34:07 INFO - 'LOGNAME': 'cltbld', 11:34:07 INFO - 'MAIL': '/var/mail/cltbld', 11:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:07 INFO - 'MOZ_NO_REMOTE': '1', 11:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:07 INFO - 'NO_EM_RESTART': '1', 11:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:07 INFO - 'PWD': '/builds/slave/test', 11:34:07 INFO - 'SHELL': '/bin/bash', 11:34:07 INFO - 'SHLVL': '1', 11:34:07 INFO - 'TERM': 'linux', 11:34:07 INFO - 'TMOUT': '86400', 11:34:07 INFO - 'USER': 'cltbld', 11:34:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:07 INFO - '_': '/tools/buildbot/bin/python'} 11:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:34:07 INFO - Cleaning up... 11:34:07 INFO - Return code: 0 11:34:07 INFO - Running post-action listener: _resource_record_post_action 11:34:07 INFO - Running post-action listener: _start_resource_monitoring 11:34:07 INFO - Starting resource monitoring. 11:34:07 INFO - [mozharness: 2016-10-31 18:34:07.668928Z] Finished create-virtualenv step (success) 11:34:07 INFO - [mozharness: 2016-10-31 18:34:07.669385Z] Running install step. 11:34:07 INFO - Running pre-action listener: _resource_record_pre_action 11:34:07 INFO - Running main action method: install 11:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:07 INFO - Reading from file tmpfile_stdout 11:34:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:34:07 INFO - Reading from file tmpfile_stdout 11:34:07 INFO - Output received: 11:34:07 INFO - Usage: mozinstall [options] installer 11:34:07 INFO - Options: 11:34:07 INFO - -h, --help show this help message and exit 11:34:07 INFO - -d DEST, --destination=DEST 11:34:07 INFO - Directory to install application into. [default: 11:34:07 INFO - "/builds/slave/test"] 11:34:07 INFO - --app=APP Application being installed. [default: firefox] 11:34:07 INFO - mkdir: /builds/slave/test/build/application 11:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:34:24 INFO - Reading from file tmpfile_stdout 11:34:24 INFO - Output received: 11:34:24 INFO - /builds/slave/test/build/application/firefox/firefox 11:34:24 INFO - Running post-action listener: _resource_record_post_action 11:34:24 INFO - [mozharness: 2016-10-31 18:34:24.916919Z] Finished install step (success) 11:34:24 INFO - [mozharness: 2016-10-31 18:34:24.917192Z] Running run-tests step. 11:34:24 INFO - Running pre-action listener: _resource_record_pre_action 11:34:24 INFO - Running main action method: run_tests 11:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:34:24 INFO - Python 2.7.3 11:34:24 INFO - Return code: 0 11:34:24 INFO - grabbing minidump binary from tooltool 11:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:24 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 0x17c9f60>, '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 0x17cad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:34:24 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 11:34:24 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 11:34:24 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 11:34:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:34:24 INFO - Return code: 0 11:34:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:34:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:34:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:34:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:34:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 11:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 11:34:25 INFO - Using env: {'DISPLAY': ':0', 11:34:25 INFO - 'HOME': '/home/cltbld', 11:34:25 INFO - 'LANG': 'en_US.UTF-8', 11:34:25 INFO - 'LANGUAGE': 'en_US:en', 11:34:25 INFO - 'LOGNAME': 'cltbld', 11:34:25 INFO - 'MAIL': '/var/mail/cltbld', 11:34:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:25 INFO - 'MOZ_NO_REMOTE': '1', 11:34:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:25 INFO - 'NO_EM_RESTART': '1', 11:34:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:25 INFO - 'PWD': '/builds/slave/test', 11:34:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:25 INFO - 'SHELL': '/bin/bash', 11:34:25 INFO - 'SHLVL': '1', 11:34:25 INFO - 'TERM': 'linux', 11:34:25 INFO - 'TMOUT': '86400', 11:34:25 INFO - 'USER': 'cltbld', 11:34:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939', 11:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:25 INFO - '_': '/tools/buildbot/bin/python'} 11:34:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 11:34:25 INFO - mozversion application_buildid: 20161030033003 11:34:25 INFO - mozversion application_changeset: fdea89bad933375fd650bc2cd8fee6dc860de9bb 11:34:25 INFO - mozversion application_display_name: Nightly 11:34:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:34:25 INFO - mozversion application_name: Firefox 11:34:25 INFO - mozversion application_remotingname: firefox 11:34:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:34:25 INFO - mozversion application_vendor: Mozilla 11:34:25 INFO - mozversion application_version: 52.0a1 11:34:25 INFO - mozversion platform_buildid: 20161030033003 11:34:25 INFO - mozversion platform_changeset: fdea89bad933375fd650bc2cd8fee6dc860de9bb 11:34:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:34:25 INFO - mozversion platform_version: 52.0a1 11:34:25 INFO - using testdate: 1477938865 11:34:25 INFO - actual date: 1477938865 11:34:25 INFO - starting webserver on 'localhost:59989' 11:34:25 INFO - SUITE-START | Running 2 tests 11:34:25 INFO - TEST-START | dromaeo_css 11:34:25 INFO - operating with platform_type : linux_ 11:34:25 INFO - Initialising browser for dromaeo_css test... 11:34:25 INFO - TEST-INFO | started process 25055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyjL1vc/profile http://localhost:59989/getInfo.html) 11:34:29 INFO - PROCESS | 25055 | __metrics Screen width/height:1600/1200 11:34:29 INFO - PROCESS | 25055 | colorDepth:24 11:34:29 INFO - PROCESS | 25055 | Browser inner width/height: 1024/697 11:34:29 INFO - PROCESS | 25055 | __metrics 11:34:29 INFO - PROCESS | 25055 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:34:29 INFO - PROCESS | 25055 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:30 INFO - PROCESS | 25055 | console.error: PushService: 11:34:30 INFO - PROCESS | 25055 | stateChangeProcessEnqueue: Error transitioning state 11:34:30 INFO - PROCESS | 25055 | UnknownError 11:34:31 INFO - TEST-INFO | 25055: exit 0 11:34:31 INFO - Browser initialized. 11:34:31 INFO - Running cycle 1/1 for dromaeo_css test... 11:34:31 INFO - TEST-INFO | started process 25141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyjL1vc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:43 INFO - PROCESS | 25141 | RSS: Main: 174178304 11:34:43 INFO - PROCESS | 25141 | 11:35:34 INFO - PROCESS | 25141 | 1477938934752 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] 11:37:44 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:59989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59989/tests/dromaeo/cssquery-ext.html) 11:37:47 INFO - PROCESS | 25141 | RSS: Main: 415195136 11:37:47 INFO - PROCESS | 25141 | 11:40:49 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:59989/tests/dromaeo/cssquery-ext.html (next: http://localhost:59989/tests/dromaeo/cssquery-jquery.html) 11:40:50 INFO - PROCESS | 25141 | RSS: Main: 290349056 11:40:50 INFO - PROCESS | 25141 | 11:43:52 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:59989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59989/tests/dromaeo/cssquery-mootools.html) 11:43:52 INFO - PROCESS | 25141 | RSS: Main: 220651520 11:43:52 INFO - PROCESS | 25141 | 11:46:54 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:59989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59989/tests/dromaeo/cssquery-prototype.html) 11:46:55 INFO - PROCESS | 25141 | RSS: Main: 220213248 11:46:55 INFO - PROCESS | 25141 | 11:49:58 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:59989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59989/tests/dromaeo/cssquery-yui.html) 11:49:58 INFO - PROCESS | 25141 | RSS: Main: 220495872 11:49:58 INFO - PROCESS | 25141 | 11:53:01 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:59989/tests/dromaeo/cssquery-yui.html (next: http://localhost:59989/tests/dromaeo/cssquery-dojo.html) 11:53:01 INFO - PROCESS | 25141 | RSS: Main: 277327872 11:53:01 INFO - PROCESS | 25141 | 11:53:01 INFO - PROCESS | 25141 | __start_tp_report 11:53:01 INFO - PROCESS | 25141 | _x_x_mozilla_page_load 11:53:01 INFO - PROCESS | 25141 | _x_x_mozilla_page_load_details 11:53:01 INFO - PROCESS | 25141 | |i|pagename|runs| 11:53:01 INFO - PROCESS | 25141 | |0;dojo.html;2966.80715753476;2985.6566494853073;3020.063780228129;3025.4554180247546;3026.833524156173;5210.400803907552;5295.973520132394;5302.284191634129;5355.3305836770405;5452.4547545245505;5293.788248470066;5332.813351532697;5369;5395;5433.293671822657;4746.382970213867;4749.4775574686755;4783.258594917794;4792.760361981905;4816.903661926759;4894.045661096087;4899.069176856404;4938.037082768861;4947.604191664676;4987.800487980477;4732.195526760459;4932.7780249888665;4941.036497882914;4946.406431228275;5039.269305950635;4765.737884416356;4820.855374338776;4826.565609095163;4881.365422495089;4889.462159162489;4837.975810120962;4842.41890973082;4845.055214233226;4869.318295438641;4911.950880491185;5327.147656374961;5347.946520534822;5352.036633405985;5358.571314294847;5358.892822143574;5481.342238931354;5518.779248830042;5653.689047102408;5671;5690.7439165237665;5736.483716465496;5753.395893431213;5765.596408251424;5814.622049566765;5830.15462757902;5326.813561525328;5330.520253177233;5331.760070796785;5335.893282134336;5339.199120131933;5646.632968857011;5647.745851436695;5700.629459085146;5856.355800861902;5871.442212989759;5519.751611177507;5552.750126244328;5553.8333849984565;5553.944460555424;5557.277553917965;5564.33228012641;5620.3255609326325;5625.46558076982;5627.71861406928;5669.376368599451;5602.551795856321;5618.971905140448;5623;5665.036943719578;5682.77268909239;5637.210790489335;5641.407652196543;5641.774329026793;5641.943580564224;5704.828855134269;4295.055087880662;4319;4323.48118225815;4336.718113322624;4340.262155433584;3840.135969406861;3860.517435320585;3874.2832575973534;3913.2760439318818;3934.134490412162;5363.329583802025;5388.2725832012175;5432.402435732066;5437.619366644376;5439.184122381675;5706.258186435737;5714.628549144292;5721.942780572224;5723.341815691166;5775.8556036099435;5285.312909321764;5326.334208223972;5365.704886231295;5367.677939323653;5373.301470808848;4945.9258111128365;4953.8513844583995;4953.900921981613;4957;5003.399592048978;5890.143594033173;5891.469767720926;5900.822975310747;5901.0558310670085;5962.165296858443;5504.697241651587;5551.611387202857;5679.119736440693;5684.431556844283;5729.742161602821;5886.587938844411;5947.6431414115295;5948.524118070457;5955.970220148872;5994.910076348771;5562.91655625174;5605.355384130877;5609.747561359667;5612.719364031864;5613.971930140323;5518.392976772632;5519.39286678457;5554.028045092174;5658.85852853682;5659.915101273402;5522.30971128609;5534.252875861707;5535.916961245504;5538.584606154474;5540.916886246629;5470.152126420411;5471.452854714496;5483.588730845123;5529.364123125731;5539.723013849372;5356.743624521087;5387.838364849061;5397.78408863641;5399.541039011728;5407.107827208467;5498.5876059294915;5558.527525160407;5564.19319198722;5567.582431317586;5572.0527510324155;5457.181422786613;5473.480019398151;5476.397596264328;5481.808136715196;5485.835424937259 11:53:01 INFO - PROCESS | 25141 | |1;ext.html;588.7586089703221;593.4629160609649;605.1104875832525;614.7233744814835;622.318561175513;31018.68981310186;42326.36510452342;43199.136017279634;43343.34984975228;46632.300515492294;44098.7795061025;44114.338284925754;44509.10981780371;44558.554414455844;44604;7931.722389716361;8558.44370115942;8721.694740684077;8729.170728780788;8735.1701588349;7961.36309095271;8281.17188281173;8283.83432331353;10392.48037598121;10732.463376831167;10586.470676466184;10662.413567253798;10663.680089597325;10669.093127084207;10677.35935843848;10475.26673132881;10476.842847357295;10483.947580262125;10521.947390263;10550.208734344955;10452.790944181073;10507.474626268657;10520.263581549294;10524.368537887674;10525.631602893938;39952.20095598101;40204.39693404601;40264.79867600673;40366.79816600928;40383.39424908629;3358.899233023013;3468.323676883009;3623.8912832615065;3857.24783667185;4008.7594744315143;29860.402791944038;30771;30799.384012319853;30945.845270773727;31098.689013109804;4321.935170972438;4384.846530371422;4563.703359281636;4621.029583787408;4631.328457373662;310097;313063;314529;314689;315255;33346.3330733384;34322.65677343245;34357;55920.720396398574;56205.7189714057;34932;35045.82477087598;35151.82424087914;35231;35307.4703879442;14043.368048437846;14141.929290353482;14180.290985450687;14220.786688199685;14224.644383890278;11046.558137674403;11720.413979301002;11818.054555635528;11847.407629618485;11851.762964740657;7630.084389873251;8057.395695322874;8183.71357002502;8239.423240373117;8265.917340826634;3184.792988455743;3186.2353035271367;3220.838958052088;3229.9677003229667;3255.5930508686415;927.9350445468752;936.6066252174103;978.9804203915882;995.3778888194878;1089.6730980705756;30830.84584577063;31006.844965775028;31328.21679457986;31507.527387089212;31713.608686523345;1062.5377960587168;1069.5454431866426;1075.876274228458;1120.971975700614;1124.0614087237086;15783.921080394524;16000.199990000454;16634.168291585614;16642.833571664127;16656.33374665024;516824;520124;520456;521141;524128;56009.43990560124;57030.7148464255;57101;57147.714261428424;57181.42818571844;1207.6316723399448;1239.1202246404973;1263.532492977586;1288.8775566321185;1316.1182008054434;30455.847720761256;32840;32966.83516582402;33082.66917330796;33204;48649.513504865914;49279.7536012332;49371.50628493669;49376;49386;299370;299916;299955;300180;300592;26955.326116847235;27112.593311099954;27305.863470683315;28674.283142921595;28753.281167970967;45027;45334;45472.54527454683;45894.541054589026;46218;36914.63085369112;37218.441723374715;37491.81254093712;37501.2499749998;38072;37894.621053790215;38534.42198366971;38925;40039.39940900947;40106;37794.62205377911;38701.80649096736;39124.217515650096;39292.41061384024;39455.2108957825;31202;33268.1682957928;34132;34630.480542792386;34837;26494.470110598064;26786.866065670325;27243.318917027234;27279.318017049733;27479.587806183325 11:53:01 INFO - PROCESS | 25141 | |2;jquery.html;361.84621535847276;363.12849162011156;371.24081253835897;376.0823590439328;391.8491380818384;14467.204303763288;19131.33040343588;19317.647764656478;19419;20498;17542.561435964108;18575.535611609717;18759.624807503842;19661.60676786467;19802.405927822154;5499.120140777486;5804.593678442489;5804.59367844251;5806;5808.838232353525;5578.414266501999;5686.232358631573;5707;5720.427957204288;5751.7699292028265;5680.801171958982;5704.686242256675;5705.65766054036;5716.114002329625;5718.342390625069;5446.482584154499;5573.024720673886;5587.38538760736;5606.467385598362;5701.25883635129;4902.240152776325;4921.581665558432;4924;4925.039617274633;4929.876753081166;21389.358319250292;22836.77163228363;22877.656835147485;22905.08379664828;22941.426464338525;2207.867527948328;2249.7300323961067;2297.9540409191723;2310.8266879984067;2341.2273949596593;14472.565823025327;14538.854611453857;14560.70878582433;14728.48450304245;15163.924180379028;1888.9905550472297;1918.4532408263578;1920.270297287022;1922.7981061988569;1956.2664000999625;59045.70477147587;79930;80494.59752701258;80750.59624701897;90989.54505227497;10037.447940363205;10304.896951030543;10345.534450949724;10364.170866330676;10460.895391045991;14365.281735913162;14398.640033999234;14452.277386130652;14471.204083775494;14482.565523034325;7420.257974202536;7620.69517219305;7655.6937722490475;7667.386609071261;7775.105862825734;7328.193898671142;7331.083614548182;7368.742094026683;7487.438442116863;7576.4317676174505;6077.726502307407;6258.718357673915;6269.68651567429;6325.588836725598;6358.1416508771645;1736.3315123677476;1762.1277467653595;1824.69892467744;1839.981600183981;1849.7040473524441;953.8839557717487;965.918171647745;976.5751897924425;999.5002498750624;1019.4342140112309;20167.596648066956;20538.38384848457;20916.47708807292;20952.89523552403;21021.78978210229;930.2883294279882;983.4787562591838;1003.40798928631;1022.1260821997234;1024.3393011507535;10892.891071089187;11562.537498500134;11774.764504709858;11780.528778848922;11808.586699465477;480066;482992;489592;489854;491821;83605;87943;91862;96094.51952740192;98940;1003.7691330993766;1012.767063575367;1019.2763138171832;1024.1601886453186;1028.3675539543126;16194.838051619334;16844.831551684325;17748.290068397637;17851.37520186787;18128.365507207185;30105.849470752506;31670.683293166774;42749.57250427456;43516.34725479057;44157.33763993607;60296.69851650714;60689.39310607014;61018;61925.380746191964;62778.68610656918;8062.83874322522;8270.676691729295;8324.583770811314;8525.10486398944;8578.056413794353;9396.724490356735;11980.28118312904;12437.564685235973;12840.486380544673;13112.147710398793;10990.285631433931;11021.44892755343;11132.777344452903;11219.158563107636;11633.418329083343;10628.41543715103;10630.787384252426;10938.453077345941;11042.227044106836;11278.154138439813;10650.73373165646;10676;10696.83954740664;10768.838467422838;11189.832152517556;8349.081601024003;8449.493030418194;8452.830943381221;8673.306135509018;8822.161894620001;10115.898841011496;10781.838272425763;11002.834957475485;11040.668779936615;11391.544338226378 11:53:01 INFO - PROCESS | 25141 | |3;mootools.html;1280.5262053040376;1468.8310844252915;1494.0960718765148;1618.198991499208;1763.9382621608247;7226.313500217478;7789.883151752728;8009.319207867324;8011.3991450641215;8272.255497005268;7842.451028428012;7895.171007044264;7908.881366779503;7918.683252669886;7923.088844782852;2297.3452566018645;2321.280403075052;2322.7212734471805;2330.149495434171;2331.3006098170567;2303;2352.764723527651;2356.69362982812;2359.0563774490256;2372.478054827935;2252.88735563222;2280.8289378296695;2283.691701620285;2283.7031185945802;2295;2255.9210427634953;2263.592553340398;2269.909203631853;2276.84062115652;2280.9885950570224;2246.7303923529116;2266.6260067089074;2302.504961433283;2308.90764369425;2312.4681323295567;8050.758477245633;8072.677092916277;8129.227723366271;8131.105578386373;8134.227248411392;5077.543021128116;5298.258243845865;5298.708571028592;5307.893842123136;5309.256704061435;3351.7821341612716;3428.3486137633768;3460;3488.8081155536433;3489.214926641511;1165.4526534859572;1200.4297958469745;1260.5714057220498;1261.211742660837;2122.713433686448;10637.414942178177;11032.062274706659;11041.613543526018;11046.005859472605;11054.392008439532;4292.806823692878;4298.591633794785;4364.607185353333;4385.254506733799;4387.956120438818;9397.765055873659;9450.763730906783;9451.810963780687;9466.574004169828;9469.763255918519;5048.697078175248;5049.040682270357;5053.545180933734;5053.69677819332;5058.9494105058475;4005.5193376794973;4189;4280;4755;4824.131656301829;3589.300086483163;3624.637536246354;3703.129764505339;3730.309892669865;3795.367991763513;1129.3562669278433;1162.81394976805;1164.1908873332952;1173.9178257521892;1174.2191442690687;942.2744486745167;957.5403806173076;961.5769061612868;974.7027156717269;975.1077763846143;5422.783088676488;5472.452754724575;5507.5593952484505;5547.11246200606;5858.619189752652;449.63804137668836;454.9749763763025;457.39395301225346;461.4093959731549;470.21004712083345;3647.2887786881834;3790.677792387623;3878.224355128929;3908.7654740715648;3998.7000974926414;9734.853977190347;10416.843747343795;10577.100946419641;10578.894211057945;10608.787824243625;10246.846297305547;10324.43215623148;10500.527476263587;10534.736631584272;10541;7365.558066516026;7562.697492100365;7717.305442510201;7731.690732370755;7735.690572377154;5397.217403476396;5487.122060470306;5591;5636;5764.394738552392;9257.259419246579;9307.72076837696;9413.341066125306;9495.857562136436;9501.762455938657;8536.146385361415;8840.778980525281;9161.129692679186;9405.95297023538;9539.189168920719;6692.59844409337;6834.794956151323;6840.042394064934;6950.270221626859;7081.681324340314;7849.60751962411;7943.642536085775;7994.720184793504;7995.400344974267;8016.679332826621;7029.648517573998;7053.4004609608755;7169.354758071799;7180.676869540779;7280.271972802678;6885.724571017103;6984.196817366068;7004.684789184397;7015.543989640657;7258.637068146466;6269.717862696099;6461.57999730016;6744.460443164437;6804.251532331538;6805.4895882808;4896;4908.828191013297;4966.428860680923;5004.524570165829;5035.345405097314;5013.573846223112;5018.1218286800395;5094.898102038012;5166.225066240094;5176.9741151294 11:53:01 INFO - PROCESS | 25141 | |4;prototype.html;315.5685443656626;319.447356073992;323.18073683213055;324.5278120334913;326.9019294211736;5266.605004624659;5290.576753859692;5307.469253074691;5314.282571852798;5316.3354580677415;5213.973930130344;5235.371755389358;5242.161254199329;5248.396434410044;5254.527092561669;3870.4000879863597;3987.6610488108545;4019.176068905882;4074.5517993020744;4085.9182816343655;4093.6520395766397;4103.938440923389;4104.8152833122585;4115.753054816706;4144.502659680843;4038.757674539522;4039.6768258539246;4050.939235911449;4059.3707975263733;4085.754854708727;3847.384418493056;3894.922101557967;3993.760374377532;4063.3701776224734;4070.267351876661;3592.191756854713;3594.634039065165;3595.26297109092;3612.9277414451562;3618.6381361863864;4989.251612258154;5005.324281222025;5036.546710796009;5085.338905942203;5091;4456.19788438081;4613.492515823256;4633.142868569292;4684.203685373494;4691.859244222679;5437.864053398657;5450.018996580614;5451.391839407384;5455.399906010336;5471;3927.2538217738825;3931.8820435386983;3936.6063393660693;3952.703547233969;3989.8204580793936;5552.222688823568;5584.888302233973;5730.455606717355;5748.19525266463;5764.827055188351;4065.9593404066172;4071.9389209161886;4089.488813898263;4092.5907409258834;4093.7514058211937;4149.315362965137;4150.79246037703;4151.169766046803;4155.750654960651;4156.501219853637;4434.5343738907595;4655.4180727409075;4736.976315118402;4758.286257061399;4763.642726795504;5515.4760297771645;5517.5585953123655;5524.226608274845;5562.3881373048935;5615.157726341;1381.5579014715195;1400.2788563889605;1401.3044216497947;1406.3952500424712;1409.5982644946346;837.1962915600969;878.3763527895265;884.2351366068433;895.5880295064213;896.6951236579595;5146.202338637517;5165.793368265303;5282.656627319212;5328.520433161034;5350.438203988525;5605.411431799603;5605.45849891275;5609.242752228479;5654.943450565524;5668.744906479218;5179.896402072013;5244.187150991603;5312.840614781563;5350.277712508761;5378.596605254622;2945;2963.5110206816066;2980.508216144355;2986.2982199183175;2989.760819134464;5827.650340979555;5828.184054232411;5849.327327357323;5894.263217097863;5900.734466948998;5517.917231241535;5660.462256085665;5677.914831277534;5703.800366987136;5757.625754325955;5810.1575271586225;5833;5879.911801323069;5881.470667639847;5893.351731309553;5485.533729633026;5646.661200327993;5662.745176466987;5685.744141513725;5696.376532688164;5519.3652729936575;5522.6134170609275;5529.640573362719;5531.557475402039;5587.916181257366;5781.762213160643;5810.448007439287;5866.149408335853;5906.26171728534;5923.170756094237;3905.863294784669;3955.8417663293144;3962.623550762673;4011.45845310891;4018.618231268025;5552.583556233218;5591.552675786009;5598.552115830642;5643.294588176478;5645.520130788929;5494.313210848644;5496.203050557567;5505.614606977473;5511.559075273888;5531.668099914018;5232.895342093213;5454;5505.421930697219;5505.642133261325;5516.282883225155;5370.543503802064;5396.111361023611;5444.972775136099;5457.345118585637;5469.124940009579;5302.522772950453;5396.271503347155;5480.890382192254;5534.861628459321;5564.527015203753;5433.755481003285;5435.646682965595;5443.401225865231;5473.370562385377;5475.890482190413 11:53:01 INFO - PROCESS | 25141 | |5;yui.html;697.8011266788963;701.6702149989504;756.1946526948799;761.7600455856401;770.2567022822975;14298.784603308719;15193.772093418607;15196.772048419283;15233.466828660985;15353.769693454607;13653.317334133279;13952.790708139386;13969.860301396982;13970.511032113878;13976;643.1606753187089;660.0627109504516;776.1113525013869;781.6443518199234;798.9001374828147;807.1242701668697;809.8461292354464;812.1147948735877;812.4800127918137;815.4984684419069;854.4616891358467;857.37840065952;857.5540718826206;857.9914200857974;858.433433933604;678.5657179405184;692.9618870962095;693.3343989769827;693.348252642517;849.2102344819316;607.9179310793074;613.4325748682495;615.9076138579248;616.0297531388037;618.005011930791;12308.692282692915;12314.81527777084;12331.445084971198;12341.07441941849;12359.073069519733;13009.284489353082;13168.539101131415;13178.802317965237;13383.464661413533;13388.062835601511;11557.24877882935;11663.825042624367;11681.299122052704;12050.819237711441;12224.266544007389;4234.25900467417;4282.48610166782;4295.570442955711;4508.526604706524;4511.751853648048;62277.6886115571;64114.679426603034;64269.678651606446;64740.352596474375;66048.3395166047;10459.895401046044;10639.840402393971;10728.356298622108;10844.783104337868;11257.943710281395;19534.511637209183;19558;19565.21739130447;19581.314653987043;19585.1186696599;7680.924670546128;7817.452778305464;7821;8076.152004039492;8125.431219814556;4373.781310934441;4395.516493185747;4534.13851368239;4589.380433641482;4605.148047611203;3295.47272436409;3370.7134893533835;3377.560917080813;3388.017474932242;3389.406853800575;568.709957921463;588.349873389898;595.2024287454831;602.0818252165483;612.9203203583595;529.3885562175693;584.541135208859;598.8293336399192;611.2512172588632;651.0852252585125;8020.719274825353;8216.794580135544;8310.792230194293;8366.195081926526;8373.623186956602;517.1441264706916;602.3825578781783;607.9027355623143;675.0818886314609;706.6367361906003;3848.9807550962064;3882.592327805596;3939.2712348215673;4002.599740026032;4021.8391264349684;52062.47937520577;58204;65465.01802472967;90447.09552904387;91001;47716.5228347719;59130.40869591335;63115;64496;65931.67034164799;45658.31512527315;65687.67156164284;69000.58497952648;73131.26868731351;76101.6194919033;8859.734207973772;9047;9183.173514383738;9192.307119044814;9442.433453992508;46461.76769116133;46565;46588.30117548307;48124.75937620289;48267.27599085946;53275;62391.37608623855;63352.36647633649;64243.357566423736;64244.357556423834;12965.15726477776;13303.135296205715;13336.399862006427;13439.596812095653;13499.392527336096;12850.935745321214;13097.279649619362;13873.514426995007;14039.789403159166;14677.119372837664;11379.487923043318;12001.81997270059;12082.450547492255;12548.43532041042;12772.74454510886;13076.215427074407;13209;13638.727225455634;14064.437422503395;14141.080829746445;11991.880081199077;12009;12229.816552751894;12311.076669249664;12760.553380631633;10737.194710396596;11014.669559913216;11229.831552526883;11483.942580287045;11554.133439992202;10421.218408619536;10723.30298530593;11112.388818615054;11145.387003714874;11230.887691123311 11:53:01 INFO - PROCESS | 25141 | __end_tp_report 11:53:01 INFO - PROCESS | 25141 | __start_cc_report 11:53:01 INFO - PROCESS | 25141 | _x_x_mozilla_cycle_collect,2529 11:53:01 INFO - PROCESS | 25141 | __end_cc_report 11:53:01 INFO - PROCESS | 25141 | __startTimestamp1477939981960__endTimestamp 11:53:01 INFO - PROCESS | 25141 | 11:53:01 INFO - PROCESS | 25141 | ------- Summary: start ------- 11:53:01 INFO - PROCESS | 25141 | Number of tests: 6 11:53:01 INFO - PROCESS | 25141 | 11:53:01 INFO - PROCESS | 25141 | [#0] dojo.html Cycles:165 Average:5274.68 Median:5471.45 stddev:598.26 (10.9%) stddev-sans-first:572.04 11:53:01 INFO - PROCESS | 25141 | Values: 2966.8 2985.7 3020.1 3025.5 3026.8 5210.4 5296.0 5302.3 5355.3 5452.5 5293.8 5332.8 5369.0 5395.0 5433.3 4746.4 4749.5 4783.3 4792.8 4816.9 4894.0 4899.1 4938.0 4947.6 4987.8 4732.2 4932.8 4941.0 4946.4 5039.3 4765.7 4820.9 4826.6 4881.4 4889.5 4838.0 4842.4 4845.1 4869.3 4912.0 5327.1 5347.9 5352.0 5358.6 5358.9 5481.3 5518.8 5653.7 5671.0 5690.7 5736.5 5753.4 5765.6 5814.6 5830.2 5326.8 5330.5 5331.8 5335.9 5339.2 5646.6 5647.7 5700.6 5856.4 5871.4 5519.8 5552.8 5553.8 5553.9 5557.3 5564.3 5620.3 5625.5 5627.7 5669.4 5602.6 5619.0 5623.0 5665.0 5682.8 5637.2 5641.4 5641.8 5641.9 5704.8 4295.1 4319.0 4323.5 4336.7 4340.3 3840.1 3860.5 3874.3 3913.3 3934.1 5363.3 5388.3 5432.4 5437.6 5439.2 5706.3 5714.6 5721.9 5723.3 5775.9 5285.3 5326.3 5365.7 5367.7 5373.3 4945.9 4953.9 4953.9 4957.0 5003.4 5890.1 5891.5 5900.8 5901.1 5962.2 5504.7 5551.6 5679.1 5684.4 5729.7 5886.6 5947.6 5948.5 5956.0 5994.9 5562.9 5605.4 5609.7 5612.7 5614.0 5518.4 5519.4 5554.0 5658.9 5659.9 5522.3 5534.3 5535.9 5538.6 5540.9 5470.2 5471.5 5483.6 5529.4 5539.7 5356.7 5387.8 5397.8 5399.5 5407.1 5498.6 5558.5 5564.2 5567.6 5572.1 5457.2 5473.5 5476.4 5481.8 5485.8 11:53:01 INFO - PROCESS | 25141 | 11:53:01 INFO - PROCESS | 25141 | [#1] ext.html Cycles:180 Average:52857.11 Median:34493.74 stddev:103863.68 (301.1%) stddev-sans-first:104080.91 11:53:01 INFO - PROCESS | 25141 | Values: 588.8 593.5 605.1 614.7 622.3 31018.7 42326.4 43199.1 43343.3 46632.3 44098.8 44114.3 44509.1 44558.6 44604.0 7931.7 8558.4 8721.7 8729.2 8735.2 7961.4 8281.2 8283.8 10392.5 10732.5 10586.5 10662.4 10663.7 10669.1 10677.4 10475.3 10476.8 10483.9 10521.9 10550.2 10452.8 10507.5 10520.3 10524.4 10525.6 39952.2 40204.4 40264.8 40366.8 40383.4 3358.9 3468.3 3623.9 3857.2 4008.8 29860.4 30771.0 30799.4 30945.8 31098.7 4321.9 4384.8 4563.7 4621.0 4631.3 310097.0 313063.0 314529.0 314689.0 315255.0 33346.3 34322.7 34357.0 55920.7 56205.7 34932.0 35045.8 35151.8 35231.0 35307.5 14043.4 14141.9 14180.3 14220.8 14224.6 11046.6 11720.4 11818.1 11847.4 11851.8 7630.1 8057.4 8183.7 8239.4 8265.9 3184.8 3186.2 3220.8 3230.0 3255.6 927.9 936.6 979.0 995.4 1089.7 30830.8 31006.8 31328.2 31507.5 31713.6 1062.5 1069.5 1075.9 1121.0 1124.1 15783.9 16000.2 16634.2 16642.8 16656.3 516824.0 520124.0 520456.0 521141.0 524128.0 56009.4 57030.7 57101.0 57147.7 57181.4 1207.6 1239.1 1263.5 1288.9 1316.1 30455.8 32840.0 32966.8 33082.7 33204.0 48649.5 49279.8 49371.5 49376.0 49386.0 299370.0 299916.0 299955.0 300180.0 300592.0 26955.3 27112.6 27305.9 28674.3 28753.3 45027.0 45334.0 45472.5 45894.5 46218.0 36914.6 37218.4 37491.8 37501.2 38072.0 37894.6 38534.4 38925.0 40039.4 40106.0 37794.6 38701.8 39124.2 39292.4 39455.2 31202.0 33268.2 34132.0 34630.5 34837.0 26494.5 26786.9 27243.3 27279.3 27479.6 11:53:01 INFO - PROCESS | 25141 | 11:53:01 INFO - PROCESS | 25141 | [#2] jquery.html Cycles:180 Average:28794.67 Median:2304.39 stddev:80302.61 (3484.8%) stddev-sans-first:80499.50 11:53:01 INFO - PROCESS | 25141 | Values: 361.8 363.1 371.2 376.1 391.8 14467.2 19131.3 19317.6 19419.0 20498.0 17542.6 18575.5 18759.6 19661.6 19802.4 5499.1 5804.6 5804.6 5806.0 5808.8 5578.4 5686.2 5707.0 5720.4 5751.8 5680.8 5704.7 5705.7 5716.1 5718.3 5446.5 5573.0 5587.4 5606.5 5701.3 4902.2 4921.6 4924.0 4925.0 4929.9 21389.4 22836.8 22877.7 22905.1 22941.4 2207.9 2249.7 2298.0 2310.8 2341.2 14472.6 14538.9 14560.7 14728.5 15163.9 1889.0 1918.5 1920.3 1922.8 1956.3 59045.7 79930.0 80494.6 80750.6 90989.5 10037.4 10304.9 10345.5 10364.2 10460.9 14365.3 14398.6 14452.3 14471.2 14482.6 7420.3 7620.7 7655.7 7667.4 7775.1 7328.2 7331.1 7368.7 7487.4 7576.4 6077.7 6258.7 6269.7 6325.6 6358.1 1736.3 1762.1 1824.7 1840.0 1849.7 953.9 965.9 976.6 999.5 1019.4 20167.6 20538.4 20916.5 20952.9 21021.8 930.3 983.5 1003.4 1022.1 1024.3 10892.9 11562.5 11774.8 11780.5 11808.6 480066.0 482992.0 489592.0 489854.0 491821.0 83605.0 87943.0 91862.0 96094.5 98940.0 1003.8 1012.8 1019.3 1024.2 1028.4 16194.8 16844.8 17748.3 17851.4 18128.4 30105.8 31670.7 42749.6 43516.3 44157.3 60296.7 60689.4 61018.0 61925.4 62778.7 8062.8 8270.7 8324.6 8525.1 8578.1 9396.7 11980.3 12437.6 12840.5 13112.1 10990.3 11021.4 11132.8 11219.2 11633.4 10628.4 10630.8 10938.5 11042.2 11278.2 10650.7 10676.0 10696.8 10768.8 11189.8 8349.1 8449.5 8452.8 8673.3 8822.2 10115.9 10781.8 11002.8 11040.7 11391.5 11:53:01 INFO - PROCESS | 25141 | 11:53:01 INFO - PROCESS | 25141 | [#3] mootools.html Cycles:180 Average:5418.93 Median:5042.02 stddev:2995.58 (59.4%) stddev-sans-first:2987.84 11:53:01 INFO - PROCESS | 25141 | Values: 1280.5 1468.8 1494.1 1618.2 1763.9 7226.3 7789.9 8009.3 8011.4 8272.3 7842.5 7895.2 7908.9 7918.7 7923.1 2297.3 2321.3 2322.7 2330.1 2331.3 2303.0 2352.8 2356.7 2359.1 2372.5 2252.9 2280.8 2283.7 2283.7 2295.0 2255.9 2263.6 2269.9 2276.8 2281.0 2246.7 2266.6 2302.5 2308.9 2312.5 8050.8 8072.7 8129.2 8131.1 8134.2 5077.5 5298.3 5298.7 5307.9 5309.3 3351.8 3428.3 3460.0 3488.8 3489.2 1165.5 1200.4 1260.6 1261.2 2122.7 10637.4 11032.1 11041.6 11046.0 11054.4 4292.8 4298.6 4364.6 4385.3 4388.0 9397.8 9450.8 9451.8 9466.6 9469.8 5048.7 5049.0 5053.5 5053.7 5058.9 4005.5 4189.0 4280.0 4755.0 4824.1 3589.3 3624.6 3703.1 3730.3 3795.4 1129.4 1162.8 1164.2 1173.9 1174.2 942.3 957.5 961.6 974.7 975.1 5422.8 5472.5 5507.6 5547.1 5858.6 449.6 455.0 457.4 461.4 470.2 3647.3 3790.7 3878.2 3908.8 3998.7 9734.9 10416.8 10577.1 10578.9 10608.8 10246.8 10324.4 10500.5 10534.7 10541.0 7365.6 7562.7 7717.3 7731.7 7735.7 5397.2 5487.1 5591.0 5636.0 5764.4 9257.3 9307.7 9413.3 9495.9 9501.8 8536.1 8840.8 9161.1 9406.0 9539.2 6692.6 6834.8 6840.0 6950.3 7081.7 7849.6 7943.6 7994.7 7995.4 8016.7 7029.6 7053.4 7169.4 7180.7 7280.3 6885.7 6984.2 7004.7 7015.5 7258.6 6269.7 6461.6 6744.5 6804.3 6805.5 4896.0 4908.8 4966.4 5004.5 5035.3 5013.6 5018.1 5094.9 5166.2 5177.0 11:53:01 INFO - PROCESS | 25141 | 11:53:01 INFO - PROCESS | 25141 | [#4] prototype.html Cycles:180 Average:4625.11 Median:5313.56 stddev:1368.68 (25.8%) stddev-sans-first:1333.74 11:53:01 INFO - PROCESS | 25141 | Values: 315.6 319.4 323.2 324.5 326.9 5266.6 5290.6 5307.5 5314.3 5316.3 5214.0 5235.4 5242.2 5248.4 5254.5 3870.4 3987.7 4019.2 4074.6 4085.9 4093.7 4103.9 4104.8 4115.8 4144.5 4038.8 4039.7 4050.9 4059.4 4085.8 3847.4 3894.9 3993.8 4063.4 4070.3 3592.2 3594.6 3595.3 3612.9 3618.6 4989.3 5005.3 5036.5 5085.3 5091.0 4456.2 4613.5 4633.1 4684.2 4691.9 5437.9 5450.0 5451.4 5455.4 5471.0 3927.3 3931.9 3936.6 3952.7 3989.8 5552.2 5584.9 5730.5 5748.2 5764.8 4066.0 4071.9 4089.5 4092.6 4093.8 4149.3 4150.8 4151.2 4155.8 4156.5 4434.5 4655.4 4737.0 4758.3 4763.6 5515.5 5517.6 5524.2 5562.4 5615.2 1381.6 1400.3 1401.3 1406.4 1409.6 837.2 878.4 884.2 895.6 896.7 5146.2 5165.8 5282.7 5328.5 5350.4 5605.4 5605.5 5609.2 5654.9 5668.7 5179.9 5244.2 5312.8 5350.3 5378.6 2945.0 2963.5 2980.5 2986.3 2989.8 5827.7 5828.2 5849.3 5894.3 5900.7 5517.9 5660.5 5677.9 5703.8 5757.6 5810.2 5833.0 5879.9 5881.5 5893.4 5485.5 5646.7 5662.7 5685.7 5696.4 5519.4 5522.6 5529.6 5531.6 5587.9 5781.8 5810.4 5866.1 5906.3 5923.2 3905.9 3955.8 3962.6 4011.5 4018.6 5552.6 5591.6 5598.6 5643.3 5645.5 5494.3 5496.2 5505.6 5511.6 5531.7 5232.9 5454.0 5505.4 5505.6 5516.3 5370.5 5396.1 5445.0 5457.3 5469.1 5302.5 5396.3 5480.9 5534.9 5564.5 5433.8 5435.6 5443.4 5473.4 5475.9 11:53:01 INFO - PROCESS | 25141 | 11:53:01 INFO - PROCESS | 25141 | [#5] yui.html Cycles:180 Average:16724.34 Median:25533.46 stddev:21365.47 (83.7%) stddev-sans-first:21391.51 11:53:01 INFO - PROCESS | 25141 | Values: 697.8 701.7 756.2 761.8 770.3 14298.8 15193.8 15196.8 15233.5 15353.8 13653.3 13952.8 13969.9 13970.5 13976.0 643.2 660.1 776.1 781.6 798.9 807.1 809.8 812.1 812.5 815.5 854.5 857.4 857.6 858.0 858.4 678.6 693.0 693.3 693.3 849.2 607.9 613.4 615.9 616.0 618.0 12308.7 12314.8 12331.4 12341.1 12359.1 13009.3 13168.5 13178.8 13383.5 13388.1 11557.2 11663.8 11681.3 12050.8 12224.3 4234.3 4282.5 4295.6 4508.5 4511.8 62277.7 64114.7 64269.7 64740.4 66048.3 10459.9 10639.8 10728.4 10844.8 11257.9 19534.5 19558.0 19565.2 19581.3 19585.1 7680.9 7817.5 7821.0 8076.2 8125.4 4373.8 4395.5 4534.1 4589.4 4605.1 3295.5 3370.7 3377.6 3388.0 3389.4 568.7 588.3 595.2 602.1 612.9 529.4 584.5 598.8 611.3 651.1 8020.7 8216.8 8310.8 8366.2 8373.6 517.1 602.4 607.9 675.1 706.6 3849.0 3882.6 3939.3 4002.6 4021.8 52062.5 58204.0 65465.0 90447.1 91001.0 47716.5 59130.4 63115.0 64496.0 65931.7 45658.3 65687.7 69000.6 73131.3 76101.6 8859.7 9047.0 9183.2 9192.3 9442.4 46461.8 46565.0 46588.3 48124.8 48267.3 53275.0 62391.4 63352.4 64243.4 64244.4 12965.2 13303.1 13336.4 13439.6 13499.4 12850.9 13097.3 13873.5 14039.8 14677.1 11379.5 12001.8 12082.5 12548.4 12772.7 13076.2 13209.0 13638.7 14064.4 14141.1 11991.9 12009.0 12229.8 12311.1 12760.6 10737.2 11014.7 11229.8 11483.9 11554.1 10421.2 10723.3 11112.4 11145.4 11230.9 11:53:01 INFO - PROCESS | 25141 | -------- Summary: end -------- 11:53:01 INFO - PROCESS | 25141 | 11:53:02 INFO - TEST-INFO | 25141: exit 0 11:53:02 INFO - TEST-OK | dromaeo_css | took 1117689ms 11:53:02 INFO - TEST-START | kraken 11:53:02 INFO - operating with platform_type : linux_ 11:53:02 INFO - Initialising browser for kraken test... 11:53:02 INFO - TEST-INFO | started process 25448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWL8I_g/profile http://localhost:59989/getInfo.html) 11:53:06 INFO - PROCESS | 25448 | __metrics Screen width/height:1600/1200 11:53:06 INFO - PROCESS | 25448 | colorDepth:24 11:53:06 INFO - PROCESS | 25448 | Browser inner width/height: 1024/697 11:53:06 INFO - PROCESS | 25448 | __metrics 11:53:07 INFO - PROCESS | 25448 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:53:07 INFO - PROCESS | 25448 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:53:08 INFO - PROCESS | 25448 | console.error: PushService: 11:53:08 INFO - PROCESS | 25448 | stateChangeProcessEnqueue: Error transitioning state 11:53:08 INFO - PROCESS | 25448 | UnknownError 11:53:08 INFO - TEST-INFO | 25448: exit 0 11:53:08 INFO - Browser initialized. 11:53:08 INFO - Running cycle 1/1 for kraken test... 11:53:08 INFO - TEST-INFO | started process 25533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWL8I_g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:53:20 INFO - PROCESS | 25533 | RSS: Main: 173707264 11:53:20 INFO - PROCESS | 25533 | 11:53:23 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59989/tests/kraken/driver.html?testName=audio-beat-detection) 11:53:24 INFO - PROCESS | 25533 | RSS: Main: 238841856 11:53:24 INFO - PROCESS | 25533 | 11:53:27 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59989/tests/kraken/driver.html?testName=audio-dft) 11:53:27 INFO - PROCESS | 25533 | RSS: Main: 217280512 11:53:27 INFO - PROCESS | 25533 | 11:53:30 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59989/tests/kraken/driver.html?testName=audio-fft) 11:53:31 INFO - PROCESS | 25533 | RSS: Main: 299724800 11:53:31 INFO - PROCESS | 25533 | 11:53:33 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59989/tests/kraken/driver.html?testName=audio-oscillator) 11:53:34 INFO - PROCESS | 25533 | RSS: Main: 210968576 11:53:34 INFO - PROCESS | 25533 | 11:53:36 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:53:36 INFO - PROCESS | 25533 | RSS: Main: 213835776 11:53:36 INFO - PROCESS | 25533 | 11:53:39 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59989/tests/kraken/driver.html?testName=imaging-darkroom) 11:53:40 INFO - PROCESS | 25533 | RSS: Main: 249536512 11:53:40 INFO - PROCESS | 25533 | 11:53:43 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59989/tests/kraken/driver.html?testName=imaging-desaturate) 11:53:44 INFO - PROCESS | 25533 | RSS: Main: 248496128 11:53:44 INFO - PROCESS | 25533 | 11:53:46 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59989/tests/kraken/driver.html?testName=json-parse-financial) 11:53:47 INFO - PROCESS | 25533 | RSS: Main: 247943168 11:53:47 INFO - PROCESS | 25533 | 11:53:49 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:53:49 INFO - PROCESS | 25533 | RSS: Main: 210546688 11:53:49 INFO - PROCESS | 25533 | 11:53:51 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59989/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:53:52 INFO - PROCESS | 25533 | RSS: Main: 218234880 11:53:52 INFO - PROCESS | 25533 | 11:53:54 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:53:54 INFO - PROCESS | 25533 | RSS: Main: 227143680 11:53:54 INFO - PROCESS | 25533 | 11:53:57 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:53:58 INFO - PROCESS | 25533 | RSS: Main: 236421120 11:53:58 INFO - PROCESS | 25533 | 11:54:00 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:54:01 INFO - PROCESS | 25533 | RSS: Main: 232103936 11:54:01 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | Cycle 1(1): loaded http://localhost:59989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59989/tests/kraken/driver.html?testName=ai-astar) 11:54:03 INFO - PROCESS | 25533 | RSS: Main: 283353088 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | __start_tp_report 11:54:03 INFO - PROCESS | 25533 | _x_x_mozilla_page_load 11:54:03 INFO - PROCESS | 25533 | _x_x_mozilla_page_load_details 11:54:03 INFO - PROCESS | 25533 | |i|pagename|runs| 11:54:03 INFO - PROCESS | 25533 | |0;ai-astar;103;112;112;113;113;112;112;111;111;112 11:54:03 INFO - PROCESS | 25533 | |1;audio-beat-detection;158;122;122;169;124;124;126;126;155;122 11:54:03 INFO - PROCESS | 25533 | |2;audio-dft;162;162;161;161;162;163;162;164;162;162 11:54:03 INFO - PROCESS | 25533 | |3;audio-fft;75;75;74;107;76;76;88;75;107;77 11:54:03 INFO - PROCESS | 25533 | |4;audio-oscillator;84;83;111;84;84;85;116;83;84;113 11:54:03 INFO - PROCESS | 25533 | |5;imaging-gaussian-blur;116;116;116;117;116;117;117;117;118;116 11:54:03 INFO - PROCESS | 25533 | |6;imaging-darkroom;146;146;146;145;145;145;145;145;145;148 11:54:03 INFO - PROCESS | 25533 | |7;imaging-desaturate;84;85;84;84;85;84;84;85;84;84 11:54:03 INFO - PROCESS | 25533 | |8;json-parse-financial;54;52;52;53;54;54;53;53;54;54 11:54:03 INFO - PROCESS | 25533 | |9;json-stringify-tinderbox;62;63;62;64;63;62;63;62;62;62 11:54:03 INFO - PROCESS | 25533 | |10;stanford-crypto-aes;79;80;80;80;80;80;80;81;81;80 11:54:03 INFO - PROCESS | 25533 | |11;stanford-crypto-ccm;134;141;137;134;135;132;138;131;172;133 11:54:03 INFO - PROCESS | 25533 | |12;stanford-crypto-pbkdf2;168;166;168;165;168;165;164;164;165;168 11:54:03 INFO - PROCESS | 25533 | |13;stanford-crypto-sha256-iterative;67;64;64;65;64;63;63;65;68;64 11:54:03 INFO - PROCESS | 25533 | __end_tp_report 11:54:03 INFO - PROCESS | 25533 | __start_cc_report 11:54:03 INFO - PROCESS | 25533 | _x_x_mozilla_cycle_collect,1711 11:54:03 INFO - PROCESS | 25533 | __end_cc_report 11:54:03 INFO - PROCESS | 25533 | __startTimestamp1477940043366__endTimestamp 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | ------- Summary: start ------- 11:54:03 INFO - PROCESS | 25533 | Number of tests: 14 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.92 (2.6%) stddev-sans-first:0.71 11:54:03 INFO - PROCESS | 25533 | Values: 103.0 112.0 112.0 113.0 113.0 112.0 112.0 111.0 111.0 112.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:126.00 stddev:18.24 (14.5%) stddev-sans-first:17.31 11:54:03 INFO - PROCESS | 25533 | Values: 158.0 122.0 122.0 169.0 124.0 124.0 126.0 126.0 155.0 122.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 11:54:03 INFO - PROCESS | 25533 | Values: 162.0 162.0 161.0 161.0 162.0 163.0 162.0 164.0 162.0 162.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.50 stddev:13.27 (17.6%) stddev-sans-first:13.75 11:54:03 INFO - PROCESS | 25533 | Values: 75.0 75.0 74.0 107.0 76.0 76.0 88.0 75.0 107.0 77.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:84.00 stddev:14.30 (17.0%) stddev-sans-first:14.82 11:54:03 INFO - PROCESS | 25533 | Values: 84.0 83.0 111.0 84.0 84.0 85.0 116.0 83.0 84.0 113.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 11:54:03 INFO - PROCESS | 25533 | Values: 116.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 118.0 116.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 11:54:03 INFO - PROCESS | 25533 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 148.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 11:54:03 INFO - PROCESS | 25533 | Values: 84.0 85.0 84.0 84.0 85.0 84.0 84.0 85.0 84.0 84.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 11:54:03 INFO - PROCESS | 25533 | Values: 54.0 52.0 52.0 53.0 54.0 54.0 53.0 53.0 54.0 54.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 11:54:03 INFO - PROCESS | 25533 | Values: 62.0 63.0 62.0 64.0 63.0 62.0 63.0 62.0 62.0 62.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:0.57 (0.7%) stddev-sans-first:0.44 11:54:03 INFO - PROCESS | 25533 | Values: 79.0 80.0 80.0 80.0 80.0 80.0 80.0 81.0 81.0 80.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:136.00 stddev:12.07 (8.9%) stddev-sans-first:12.69 11:54:03 INFO - PROCESS | 25533 | Values: 134.0 141.0 137.0 134.0 135.0 132.0 138.0 131.0 172.0 133.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:167.00 stddev:1.73 (1.0%) stddev-sans-first:1.69 11:54:03 INFO - PROCESS | 25533 | Values: 168.0 166.0 168.0 165.0 168.0 165.0 164.0 164.0 165.0 168.0 11:54:03 INFO - PROCESS | 25533 | 11:54:03 INFO - PROCESS | 25533 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.50 stddev:1.64 (2.5%) stddev-sans-first:1.51 11:54:03 INFO - PROCESS | 25533 | Values: 67.0 64.0 64.0 65.0 64.0 63.0 63.0 65.0 68.0 64.0 11:54:03 INFO - PROCESS | 25533 | -------- Summary: end -------- 11:54:03 INFO - PROCESS | 25533 | 11:54:04 INFO - TEST-INFO | 25533: exit 0 11:54:04 INFO - TEST-OK | kraken | took 61735ms 11:54:04 INFO - SUITE-END | took 1179s 11:54:05 INFO - Completed test suite (00:19:39) 11:54:05 INFO - javascript benchmark 11:54:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2966.80715753476, 2985.6566494853073, 3020.063780228129, 3025.4554180247546, 3026.833524156173, 5210.400803907552, 5295.973520132394, 5302.284191634129, 5355.3305836770405, 5452.4547545245505, 5293.788248470066, 5332.813351532697, 5369.0, 5395.0, 5433.293671822657, 4746.382970213867, 4749.4775574686755, 4783.258594917794, 4792.760361981905, 4816.903661926759, 4894.045661096087, 4899.069176856404, 4938.037082768861, 4947.604191664676, 4987.800487980477, 4732.195526760459, 4932.7780249888665, 4941.036497882914, 4946.406431228275, 5039.269305950635, 4765.737884416356, 4820.855374338776, 4826.565609095163, 4881.365422495089, 4889.462159162489, 4837.975810120962, 4842.41890973082, 4845.055214233226, 4869.318295438641, 4911.950880491185, 5327.147656374961, 5347.946520534822, 5352.036633405985, 5358.571314294847, 5358.892822143574, 5481.342238931354, 5518.779248830042, 5653.689047102408, 5671.0, 5690.7439165237665, 5736.483716465496, 5753.395893431213, 5765.596408251424, 5814.622049566765, 5830.15462757902, 5326.813561525328, 5330.520253177233, 5331.760070796785, 5335.893282134336, 5339.199120131933, 5646.632968857011, 5647.745851436695, 5700.629459085146, 5856.355800861902, 5871.442212989759, 5519.751611177507, 5552.750126244328, 5553.8333849984565, 5553.944460555424, 5557.277553917965, 5564.33228012641, 5620.3255609326325, 5625.46558076982, 5627.71861406928, 5669.376368599451, 5602.551795856321, 5618.971905140448, 5623.0, 5665.036943719578, 5682.77268909239, 5637.210790489335, 5641.407652196543, 5641.774329026793, 5641.943580564224, 5704.828855134269, 4295.055087880662, 4319.0, 4323.48118225815, 4336.718113322624, 4340.262155433584, 3840.135969406861, 3860.517435320585, 3874.2832575973534, 3913.2760439318818, 3934.134490412162, 5363.329583802025, 5388.2725832012175, 5432.402435732066, 5437.619366644376, 5439.184122381675, 5706.258186435737, 5714.628549144292, 5721.942780572224, 5723.341815691166, 5775.8556036099435, 5285.312909321764, 5326.334208223972, 5365.704886231295, 5367.677939323653, 5373.301470808848, 4945.9258111128365, 4953.8513844583995, 4953.900921981613, 4957.0, 5003.399592048978, 5890.143594033173, 5891.469767720926, 5900.822975310747, 5901.0558310670085, 5962.165296858443, 5504.697241651587, 5551.611387202857, 5679.119736440693, 5684.431556844283, 5729.742161602821, 5886.587938844411, 5947.6431414115295, 5948.524118070457, 5955.970220148872, 5994.910076348771, 5562.91655625174, 5605.355384130877, 5609.747561359667, 5612.719364031864, 5613.971930140323, 5518.392976772632, 5519.39286678457, 5554.028045092174, 5658.85852853682, 5659.915101273402, 5522.30971128609, 5534.252875861707, 5535.916961245504, 5538.584606154474, 5540.916886246629, 5470.152126420411, 5471.452854714496, 5483.588730845123, 5529.364123125731, 5539.723013849372, 5356.743624521087, 5387.838364849061, 5397.78408863641, 5399.541039011728, 5407.107827208467, 5498.5876059294915, 5558.527525160407, 5564.19319198722, 5567.582431317586, 5572.0527510324155, 5457.181422786613, 5473.480019398151, 5476.397596264328, 5481.808136715196, 5485.835424937259], "value": 5233.650909927921, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.7586089703221, 593.4629160609649, 605.1104875832525, 614.7233744814835, 622.318561175513, 31018.68981310186, 42326.36510452342, 43199.136017279634, 43343.34984975228, 46632.300515492294, 44098.7795061025, 44114.338284925754, 44509.10981780371, 44558.554414455844, 44604.0, 7931.722389716361, 8558.44370115942, 8721.694740684077, 8729.170728780788, 8735.1701588349, 7961.36309095271, 8281.17188281173, 8283.83432331353, 10392.48037598121, 10732.463376831167, 10586.470676466184, 10662.413567253798, 10663.680089597325, 10669.093127084207, 10677.35935843848, 10475.26673132881, 10476.842847357295, 10483.947580262125, 10521.947390263, 10550.208734344955, 10452.790944181073, 10507.474626268657, 10520.263581549294, 10524.368537887674, 10525.631602893938, 39952.20095598101, 40204.39693404601, 40264.79867600673, 40366.79816600928, 40383.39424908629, 3358.899233023013, 3468.323676883009, 3623.8912832615065, 3857.24783667185, 4008.7594744315143, 29860.402791944038, 30771.0, 30799.384012319853, 30945.845270773727, 31098.689013109804, 4321.935170972438, 4384.846530371422, 4563.703359281636, 4621.029583787408, 4631.328457373662, 310097.0, 313063.0, 314529.0, 314689.0, 315255.0, 33346.3330733384, 34322.65677343245, 34357.0, 55920.720396398574, 56205.7189714057, 34932.0, 35045.82477087598, 35151.82424087914, 35231.0, 35307.4703879442, 14043.368048437846, 14141.929290353482, 14180.290985450687, 14220.786688199685, 14224.644383890278, 11046.558137674403, 11720.413979301002, 11818.054555635528, 11847.407629618485, 11851.762964740657, 7630.084389873251, 8057.395695322874, 8183.71357002502, 8239.423240373117, 8265.917340826634, 3184.792988455743, 3186.2353035271367, 3220.838958052088, 3229.9677003229667, 3255.5930508686415, 927.9350445468752, 936.6066252174103, 978.9804203915882, 995.3778888194878, 1089.6730980705756, 30830.84584577063, 31006.844965775028, 31328.21679457986, 31507.527387089212, 31713.608686523345, 1062.5377960587168, 1069.5454431866426, 1075.876274228458, 1120.971975700614, 1124.0614087237086, 15783.921080394524, 16000.199990000454, 16634.168291585614, 16642.833571664127, 16656.33374665024, 516824.0, 520124.0, 520456.0, 521141.0, 524128.0, 56009.43990560124, 57030.7148464255, 57101.0, 57147.714261428424, 57181.42818571844, 1207.6316723399448, 1239.1202246404973, 1263.532492977586, 1288.8775566321185, 1316.1182008054434, 30455.847720761256, 32840.0, 32966.83516582402, 33082.66917330796, 33204.0, 48649.513504865914, 49279.7536012332, 49371.50628493669, 49376.0, 49386.0, 299370.0, 299916.0, 299955.0, 300180.0, 300592.0, 26955.326116847235, 27112.593311099954, 27305.863470683315, 28674.283142921595, 28753.281167970967, 45027.0, 45334.0, 45472.54527454683, 45894.541054589026, 46218.0, 36914.63085369112, 37218.441723374715, 37491.81254093712, 37501.2499749998, 38072.0, 37894.621053790215, 38534.42198366971, 38925.0, 40039.39940900947, 40106.0, 37794.62205377911, 38701.80649096736, 39124.217515650096, 39292.41061384024, 39455.2108957825, 31202.0, 33268.1682957928, 34132.0, 34630.480542792386, 34837.0, 26494.470110598064, 26786.866065670325, 27243.318917027234, 27279.318017049733, 27479.587806183325], "value": 18283.418492384495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.84621535847276, 363.12849162011156, 371.24081253835897, 376.0823590439328, 391.8491380818384, 14467.204303763288, 19131.33040343588, 19317.647764656478, 19419.0, 20498.0, 17542.561435964108, 18575.535611609717, 18759.624807503842, 19661.60676786467, 19802.405927822154, 5499.120140777486, 5804.593678442489, 5804.59367844251, 5806.0, 5808.838232353525, 5578.414266501999, 5686.232358631573, 5707.0, 5720.427957204288, 5751.7699292028265, 5680.801171958982, 5704.686242256675, 5705.65766054036, 5716.114002329625, 5718.342390625069, 5446.482584154499, 5573.024720673886, 5587.38538760736, 5606.467385598362, 5701.25883635129, 4902.240152776325, 4921.581665558432, 4924.0, 4925.039617274633, 4929.876753081166, 21389.358319250292, 22836.77163228363, 22877.656835147485, 22905.08379664828, 22941.426464338525, 2207.867527948328, 2249.7300323961067, 2297.9540409191723, 2310.8266879984067, 2341.2273949596593, 14472.565823025327, 14538.854611453857, 14560.70878582433, 14728.48450304245, 15163.924180379028, 1888.9905550472297, 1918.4532408263578, 1920.270297287022, 1922.7981061988569, 1956.2664000999625, 59045.70477147587, 79930.0, 80494.59752701258, 80750.59624701897, 90989.54505227497, 10037.447940363205, 10304.896951030543, 10345.534450949724, 10364.170866330676, 10460.895391045991, 14365.281735913162, 14398.640033999234, 14452.277386130652, 14471.204083775494, 14482.565523034325, 7420.257974202536, 7620.69517219305, 7655.6937722490475, 7667.386609071261, 7775.105862825734, 7328.193898671142, 7331.083614548182, 7368.742094026683, 7487.438442116863, 7576.4317676174505, 6077.726502307407, 6258.718357673915, 6269.68651567429, 6325.588836725598, 6358.1416508771645, 1736.3315123677476, 1762.1277467653595, 1824.69892467744, 1839.981600183981, 1849.7040473524441, 953.8839557717487, 965.918171647745, 976.5751897924425, 999.5002498750624, 1019.4342140112309, 20167.596648066956, 20538.38384848457, 20916.47708807292, 20952.89523552403, 21021.78978210229, 930.2883294279882, 983.4787562591838, 1003.40798928631, 1022.1260821997234, 1024.3393011507535, 10892.891071089187, 11562.537498500134, 11774.764504709858, 11780.528778848922, 11808.586699465477, 480066.0, 482992.0, 489592.0, 489854.0, 491821.0, 83605.0, 87943.0, 91862.0, 96094.51952740192, 98940.0, 1003.7691330993766, 1012.767063575367, 1019.2763138171832, 1024.1601886453186, 1028.3675539543126, 16194.838051619334, 16844.831551684325, 17748.290068397637, 17851.37520186787, 18128.365507207185, 30105.849470752506, 31670.683293166774, 42749.57250427456, 43516.34725479057, 44157.33763993607, 60296.69851650714, 60689.39310607014, 61018.0, 61925.380746191964, 62778.68610656918, 8062.83874322522, 8270.676691729295, 8324.583770811314, 8525.10486398944, 8578.056413794353, 9396.724490356735, 11980.28118312904, 12437.564685235973, 12840.486380544673, 13112.147710398793, 10990.285631433931, 11021.44892755343, 11132.777344452903, 11219.158563107636, 11633.418329083343, 10628.41543715103, 10630.787384252426, 10938.453077345941, 11042.227044106836, 11278.154138439813, 10650.73373165646, 10676.0, 10696.83954740664, 10768.838467422838, 11189.832152517556, 8349.081601024003, 8449.493030418194, 8452.830943381221, 8673.306135509018, 8822.161894620001, 10115.898841011496, 10781.838272425763, 11002.834957475485, 11040.668779936615, 11391.544338226378], "value": 9135.962291727958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.5262053040376, 1468.8310844252915, 1494.0960718765148, 1618.198991499208, 1763.9382621608247, 7226.313500217478, 7789.883151752728, 8009.319207867324, 8011.3991450641215, 8272.255497005268, 7842.451028428012, 7895.171007044264, 7908.881366779503, 7918.683252669886, 7923.088844782852, 2297.3452566018645, 2321.280403075052, 2322.7212734471805, 2330.149495434171, 2331.3006098170567, 2303.0, 2352.764723527651, 2356.69362982812, 2359.0563774490256, 2372.478054827935, 2252.88735563222, 2280.8289378296695, 2283.691701620285, 2283.7031185945802, 2295.0, 2255.9210427634953, 2263.592553340398, 2269.909203631853, 2276.84062115652, 2280.9885950570224, 2246.7303923529116, 2266.6260067089074, 2302.504961433283, 2308.90764369425, 2312.4681323295567, 8050.758477245633, 8072.677092916277, 8129.227723366271, 8131.105578386373, 8134.227248411392, 5077.543021128116, 5298.258243845865, 5298.708571028592, 5307.893842123136, 5309.256704061435, 3351.7821341612716, 3428.3486137633768, 3460.0, 3488.8081155536433, 3489.214926641511, 1165.4526534859572, 1200.4297958469745, 1260.5714057220498, 1261.211742660837, 2122.713433686448, 10637.414942178177, 11032.062274706659, 11041.613543526018, 11046.005859472605, 11054.392008439532, 4292.806823692878, 4298.591633794785, 4364.607185353333, 4385.254506733799, 4387.956120438818, 9397.765055873659, 9450.763730906783, 9451.810963780687, 9466.574004169828, 9469.763255918519, 5048.697078175248, 5049.040682270357, 5053.545180933734, 5053.69677819332, 5058.9494105058475, 4005.5193376794973, 4189.0, 4280.0, 4755.0, 4824.131656301829, 3589.300086483163, 3624.637536246354, 3703.129764505339, 3730.309892669865, 3795.367991763513, 1129.3562669278433, 1162.81394976805, 1164.1908873332952, 1173.9178257521892, 1174.2191442690687, 942.2744486745167, 957.5403806173076, 961.5769061612868, 974.7027156717269, 975.1077763846143, 5422.783088676488, 5472.452754724575, 5507.5593952484505, 5547.11246200606, 5858.619189752652, 449.63804137668836, 454.9749763763025, 457.39395301225346, 461.4093959731549, 470.21004712083345, 3647.2887786881834, 3790.677792387623, 3878.224355128929, 3908.7654740715648, 3998.7000974926414, 9734.853977190347, 10416.843747343795, 10577.100946419641, 10578.894211057945, 10608.787824243625, 10246.846297305547, 10324.43215623148, 10500.527476263587, 10534.736631584272, 10541.0, 7365.558066516026, 7562.697492100365, 7717.305442510201, 7731.690732370755, 7735.690572377154, 5397.217403476396, 5487.122060470306, 5591.0, 5636.0, 5764.394738552392, 9257.259419246579, 9307.72076837696, 9413.341066125306, 9495.857562136436, 9501.762455938657, 8536.146385361415, 8840.778980525281, 9161.129692679186, 9405.95297023538, 9539.189168920719, 6692.59844409337, 6834.794956151323, 6840.042394064934, 6950.270221626859, 7081.681324340314, 7849.60751962411, 7943.642536085775, 7994.720184793504, 7995.400344974267, 8016.679332826621, 7029.648517573998, 7053.4004609608755, 7169.354758071799, 7180.676869540779, 7280.271972802678, 6885.724571017103, 6984.196817366068, 7004.684789184397, 7015.543989640657, 7258.637068146466, 6269.717862696099, 6461.57999730016, 6744.460443164437, 6804.251532331538, 6805.4895882808, 4896.0, 4908.828191013297, 4966.428860680923, 5004.524570165829, 5035.345405097314, 5013.573846223112, 5018.1218286800395, 5094.898102038012, 5166.225066240094, 5176.9741151294], "value": 4344.550628840998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.5685443656626, 319.447356073992, 323.18073683213055, 324.5278120334913, 326.9019294211736, 5266.605004624659, 5290.576753859692, 5307.469253074691, 5314.282571852798, 5316.3354580677415, 5213.973930130344, 5235.371755389358, 5242.161254199329, 5248.396434410044, 5254.527092561669, 3870.4000879863597, 3987.6610488108545, 4019.176068905882, 4074.5517993020744, 4085.9182816343655, 4093.6520395766397, 4103.938440923389, 4104.8152833122585, 4115.753054816706, 4144.502659680843, 4038.757674539522, 4039.6768258539246, 4050.939235911449, 4059.3707975263733, 4085.754854708727, 3847.384418493056, 3894.922101557967, 3993.760374377532, 4063.3701776224734, 4070.267351876661, 3592.191756854713, 3594.634039065165, 3595.26297109092, 3612.9277414451562, 3618.6381361863864, 4989.251612258154, 5005.324281222025, 5036.546710796009, 5085.338905942203, 5091.0, 4456.19788438081, 4613.492515823256, 4633.142868569292, 4684.203685373494, 4691.859244222679, 5437.864053398657, 5450.018996580614, 5451.391839407384, 5455.399906010336, 5471.0, 3927.2538217738825, 3931.8820435386983, 3936.6063393660693, 3952.703547233969, 3989.8204580793936, 5552.222688823568, 5584.888302233973, 5730.455606717355, 5748.19525266463, 5764.827055188351, 4065.9593404066172, 4071.9389209161886, 4089.488813898263, 4092.5907409258834, 4093.7514058211937, 4149.315362965137, 4150.79246037703, 4151.169766046803, 4155.750654960651, 4156.501219853637, 4434.5343738907595, 4655.4180727409075, 4736.976315118402, 4758.286257061399, 4763.642726795504, 5515.4760297771645, 5517.5585953123655, 5524.226608274845, 5562.3881373048935, 5615.157726341, 1381.5579014715195, 1400.2788563889605, 1401.3044216497947, 1406.3952500424712, 1409.5982644946346, 837.1962915600969, 878.3763527895265, 884.2351366068433, 895.5880295064213, 896.6951236579595, 5146.202338637517, 5165.793368265303, 5282.656627319212, 5328.520433161034, 5350.438203988525, 5605.411431799603, 5605.45849891275, 5609.242752228479, 5654.943450565524, 5668.744906479218, 5179.896402072013, 5244.187150991603, 5312.840614781563, 5350.277712508761, 5378.596605254622, 2945.0, 2963.5110206816066, 2980.508216144355, 2986.2982199183175, 2989.760819134464, 5827.650340979555, 5828.184054232411, 5849.327327357323, 5894.263217097863, 5900.734466948998, 5517.917231241535, 5660.462256085665, 5677.914831277534, 5703.800366987136, 5757.625754325955, 5810.1575271586225, 5833.0, 5879.911801323069, 5881.470667639847, 5893.351731309553, 5485.533729633026, 5646.661200327993, 5662.745176466987, 5685.744141513725, 5696.376532688164, 5519.3652729936575, 5522.6134170609275, 5529.640573362719, 5531.557475402039, 5587.916181257366, 5781.762213160643, 5810.448007439287, 5866.149408335853, 5906.26171728534, 5923.170756094237, 3905.863294784669, 3955.8417663293144, 3962.623550762673, 4011.45845310891, 4018.618231268025, 5552.583556233218, 5591.552675786009, 5598.552115830642, 5643.294588176478, 5645.520130788929, 5494.313210848644, 5496.203050557567, 5505.614606977473, 5511.559075273888, 5531.668099914018, 5232.895342093213, 5454.0, 5505.421930697219, 5505.642133261325, 5516.282883225155, 5370.543503802064, 5396.111361023611, 5444.972775136099, 5457.345118585637, 5469.124940009579, 5302.522772950453, 5396.271503347155, 5480.890382192254, 5534.861628459321, 5564.527015203753, 5433.755481003285, 5435.646682965595, 5443.401225865231, 5473.370562385377, 5475.890482190413], "value": 4182.266489922219, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.8011266788963, 701.6702149989504, 756.1946526948799, 761.7600455856401, 770.2567022822975, 14298.784603308719, 15193.772093418607, 15196.772048419283, 15233.466828660985, 15353.769693454607, 13653.317334133279, 13952.790708139386, 13969.860301396982, 13970.511032113878, 13976.0, 643.1606753187089, 660.0627109504516, 776.1113525013869, 781.6443518199234, 798.9001374828147, 807.1242701668697, 809.8461292354464, 812.1147948735877, 812.4800127918137, 815.4984684419069, 854.4616891358467, 857.37840065952, 857.5540718826206, 857.9914200857974, 858.433433933604, 678.5657179405184, 692.9618870962095, 693.3343989769827, 693.348252642517, 849.2102344819316, 607.9179310793074, 613.4325748682495, 615.9076138579248, 616.0297531388037, 618.005011930791, 12308.692282692915, 12314.81527777084, 12331.445084971198, 12341.07441941849, 12359.073069519733, 13009.284489353082, 13168.539101131415, 13178.802317965237, 13383.464661413533, 13388.062835601511, 11557.24877882935, 11663.825042624367, 11681.299122052704, 12050.819237711441, 12224.266544007389, 4234.25900467417, 4282.48610166782, 4295.570442955711, 4508.526604706524, 4511.751853648048, 62277.6886115571, 64114.679426603034, 64269.678651606446, 64740.352596474375, 66048.3395166047, 10459.895401046044, 10639.840402393971, 10728.356298622108, 10844.783104337868, 11257.943710281395, 19534.511637209183, 19558.0, 19565.21739130447, 19581.314653987043, 19585.1186696599, 7680.924670546128, 7817.452778305464, 7821.0, 8076.152004039492, 8125.431219814556, 4373.781310934441, 4395.516493185747, 4534.13851368239, 4589.380433641482, 4605.148047611203, 3295.47272436409, 3370.7134893533835, 3377.560917080813, 3388.017474932242, 3389.406853800575, 568.709957921463, 588.349873389898, 595.2024287454831, 602.0818252165483, 612.9203203583595, 529.3885562175693, 584.541135208859, 598.8293336399192, 611.2512172588632, 651.0852252585125, 8020.719274825353, 8216.794580135544, 8310.792230194293, 8366.195081926526, 8373.623186956602, 517.1441264706916, 602.3825578781783, 607.9027355623143, 675.0818886314609, 706.6367361906003, 3848.9807550962064, 3882.592327805596, 3939.2712348215673, 4002.599740026032, 4021.8391264349684, 52062.47937520577, 58204.0, 65465.01802472967, 90447.09552904387, 91001.0, 47716.5228347719, 59130.40869591335, 63115.0, 64496.0, 65931.67034164799, 45658.31512527315, 65687.67156164284, 69000.58497952648, 73131.26868731351, 76101.6194919033, 8859.734207973772, 9047.0, 9183.173514383738, 9192.307119044814, 9442.433453992508, 46461.76769116133, 46565.0, 46588.30117548307, 48124.75937620289, 48267.27599085946, 53275.0, 62391.37608623855, 63352.36647633649, 64243.357566423736, 64244.357556423834, 12965.15726477776, 13303.135296205715, 13336.399862006427, 13439.596812095653, 13499.392527336096, 12850.935745321214, 13097.279649619362, 13873.514426995007, 14039.789403159166, 14677.119372837664, 11379.487923043318, 12001.81997270059, 12082.450547492255, 12548.43532041042, 12772.74454510886, 13076.215427074407, 13209.0, 13638.727225455634, 14064.437422503395, 14141.080829746445, 11991.880081199077, 12009.0, 12229.816552751894, 12311.076669249664, 12760.553380631633, 10737.194710396596, 11014.669559913216, 11229.831552526883, 11483.942580287045, 11554.133439992202, 10421.218408619536, 10723.30298530593, 11112.388818615054, 11145.387003714874, 11230.887691123311], "value": 6842.965420058125, "unit": "score"}], "name": "dromaeo_css", "value": 6908.391643458956, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 113.0, 113.0, 112.0, 112.0, 111.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 122.0, 122.0, 169.0, 124.0, 124.0, 126.0, 126.0, 155.0, 122.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 163.0, 162.0, 164.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 107.0, 76.0, 76.0, 88.0, 75.0, 107.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 111.0, 84.0, 84.0, 85.0, 116.0, 83.0, 84.0, 113.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 148.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 53.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 64.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 80.0, 80.0, 80.0, 80.0, 81.0, 81.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 137.0, 134.0, 135.0, 132.0, 138.0, 131.0, 172.0, 133.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 168.0, 165.0, 168.0, 165.0, 164.0, 164.0, 165.0, 168.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 65.0, 64.0, 63.0, 63.0, 65.0, 68.0, 64.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1495.6, "alertThreshold": 2.0}]} 11:54:05 INFO - Return code: 0 11:54:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:54:05 INFO - # TBPL SUCCESS # 11:54:05 INFO - Running post-action listener: _resource_record_post_action 11:54:05 INFO - [mozharness: 2016-10-31 18:54:05.162304Z] Finished run-tests step (success) 11:54:05 INFO - Running post-run listener: _resource_record_post_run 11:54:05 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 396832768; Read time: 24; Write time: 278856 11:54:05 INFO - TinderboxPrint: CPU usage
13.0% 11:54:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 11:54:05 INFO - TinderboxPrint: I/O write bytes / time
396,832,768 / 278,856 11:54:05 INFO - TinderboxPrint: CPU idle
8,305.7 (87.0%) 11:54:05 INFO - TinderboxPrint: CPU user
1,194.5 (12.5%) 11:54:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:54:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103993344; Read time: 0; Write time: 93904 11:54:05 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289243136; Read time: 0; Write time: 184248 11:54:05 INFO - Running post-run listener: _upload_blobber_files 11:54:05 INFO - Blob upload gear active. 11:54:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:54:05 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 11:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:54:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:54:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:54:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:54:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:09 INFO - (blobuploader) - INFO - Done attempting. 11:54:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:54:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:54:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:09 INFO - (blobuploader) - INFO - Done attempting. 11:54:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:54:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:54:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:10 INFO - (blobuploader) - INFO - Done attempting. 11:54:10 INFO - (blobuploader) - INFO - Iteration through files over. 11:54:10 INFO - Return code: 0 11:54:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:54:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:54:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/997b76e6ec0d625cbf6ebc93fac6a49ce83d4ece8844301c6cf13fcd8cbd133f21c11aeedb4a493acc84cce6718c29bf047b1c9a8699f1509d459b35314dbc76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4393e8e0cbdee9ca3d44b5095b7cd248f3b5b31161cef8cdbed4352b8f22db7a27cbb9d4eac92d7efa3fbbc84978571983460b341d82f9182b3393391884b43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9be3a6bfc6e7a660c6fa51a17c41d9dbe82ae464722018bbb2731e941f3104cb83ae5feb4ed44f8dffa06bf13478f28eda2406eecd593e7adbfb7af38e5654be"} 11:54:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:54:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:54:10 INFO - Contents: 11:54:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/997b76e6ec0d625cbf6ebc93fac6a49ce83d4ece8844301c6cf13fcd8cbd133f21c11aeedb4a493acc84cce6718c29bf047b1c9a8699f1509d459b35314dbc76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4393e8e0cbdee9ca3d44b5095b7cd248f3b5b31161cef8cdbed4352b8f22db7a27cbb9d4eac92d7efa3fbbc84978571983460b341d82f9182b3393391884b43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9be3a6bfc6e7a660c6fa51a17c41d9dbe82ae464722018bbb2731e941f3104cb83ae5feb4ed44f8dffa06bf13478f28eda2406eecd593e7adbfb7af38e5654be"} 11:54:10 INFO - Running post-run listener: copy_logs_to_upload_dir 11:54:10 INFO - Copying logs to upload dir... 11:54:10 INFO - mkdir: /builds/slave/test/build/upload/logs 11:54:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.670414 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-31 11:54:10.553374) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 11:54:10.557149) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/997b76e6ec0d625cbf6ebc93fac6a49ce83d4ece8844301c6cf13fcd8cbd133f21c11aeedb4a493acc84cce6718c29bf047b1c9a8699f1509d459b35314dbc76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4393e8e0cbdee9ca3d44b5095b7cd248f3b5b31161cef8cdbed4352b8f22db7a27cbb9d4eac92d7efa3fbbc84978571983460b341d82f9182b3393391884b43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9be3a6bfc6e7a660c6fa51a17c41d9dbe82ae464722018bbb2731e941f3104cb83ae5feb4ed44f8dffa06bf13478f28eda2406eecd593e7adbfb7af38e5654be"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477823403/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/997b76e6ec0d625cbf6ebc93fac6a49ce83d4ece8844301c6cf13fcd8cbd133f21c11aeedb4a493acc84cce6718c29bf047b1c9a8699f1509d459b35314dbc76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4393e8e0cbdee9ca3d44b5095b7cd248f3b5b31161cef8cdbed4352b8f22db7a27cbb9d4eac92d7efa3fbbc84978571983460b341d82f9182b3393391884b43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9be3a6bfc6e7a660c6fa51a17c41d9dbe82ae464722018bbb2731e941f3104cb83ae5feb4ed44f8dffa06bf13478f28eda2406eecd593e7adbfb7af38e5654be"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 11:54:10.588516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 11:54:10.589084) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477938811.130796-1624999939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 11:54:10.671702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 11:54:10.672180) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 11:54:10.672609) ========= ========= Total master_lag: 0.19 =========