builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1475810746.17 results: success (0) buildid: 20161006202146 builduid: 5bc7a37d13d34404af75cf50d764fa3d revision: 5322af204cb05bea9336b2a500cc65f6a2549575 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:46.170451) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:46.171442) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:46.172073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:46.188428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:46.188853) ========= 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=db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 20:25:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 933K=0.01s 2016-10-06 20:25:46 (933 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153103 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:46.356428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:46.356863) ========= 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=db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019304 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:46.406550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 20:25:46.407022) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5322af204cb05bea9336b2a500cc65f6a2549575 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 5322af204cb05bea9336b2a500cc65f6a2549575 --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=db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 20:25:46,675 truncating revision to first 12 chars 2016-10-06 20:25:46,675 Setting DEBUG logging. 2016-10-06 20:25:46,675 attempt 1/10 2016-10-06 20:25:46,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5322af204cb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 20:25:47,320 unpacking tar archive at: autoland-5322af204cb0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.016065 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 20:25:47.436928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:47.437298) ========= script_repo_revision: 5322af204cb05bea9336b2a500cc65f6a2549575 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:47.437760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:47.438064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 20:25:47.447381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-06 20:25:47.447762) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:25:47 INFO - MultiFileLogger online at 20161006 20:25:47 in /builds/slave/test 20:25:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:25:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:25:47 INFO - {'append_to_log': False, 20:25:47 INFO - 'base_work_dir': '/builds/slave/test', 20:25:47 INFO - 'blob_upload_branch': 'Autoland', 20:25:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:25:47 INFO - 'branch': 'Autoland', 20:25:47 INFO - 'buildbot_json_path': 'buildprops.json', 20:25:47 INFO - 'config_files': ('talos/linux_config.py',), 20:25:47 INFO - 'default_actions': ('clobber', 20:25:47 INFO - 'read-buildbot-config', 20:25:47 INFO - 'download-and-extract', 20:25:47 INFO - 'populate-webroot', 20:25:47 INFO - 'create-virtualenv', 20:25:47 INFO - 'install', 20:25:47 INFO - 'run-tests'), 20:25:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:25:47 INFO - 'download_minidump_stackwalk': True, 20:25:47 INFO - 'download_symbols': 'ondemand', 20:25:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:25:47 INFO - 'tooltool.py': '/tools/tooltool.py', 20:25:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:25:47 INFO - '/tools/misc-python/virtualenv.py')}, 20:25:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:25:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:25:47 INFO - 'installer_path': 'installer.exe', 20:25:47 INFO - 'log_level': 'info', 20:25:47 INFO - 'log_name': 'talos', 20:25:47 INFO - 'log_to_console': True, 20:25:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:25:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:25:47 INFO - 'opt_config_files': (), 20:25:47 INFO - 'pip_index': False, 20:25:47 INFO - 'sps_profile': False, 20:25:47 INFO - 'sps_profile_interval': 0, 20:25:47 INFO - 'suite': 'dromaeojs-e10s', 20:25:47 INFO - 'system_bits': '32', 20:25:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:25:47 INFO - 'title': 'talos-linux64-ix-031', 20:25:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:25:47 INFO - 'use_talos_json': True, 20:25:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:25:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:25:47 INFO - 'work_dir': 'build'} 20:25:47 INFO - [mozharness: 2016-10-07 03:25:47.828171Z] Running clobber step. 20:25:47 INFO - Running pre-action listener: _resource_record_pre_action 20:25:47 INFO - Running main action method: clobber 20:25:47 INFO - rmtree: /builds/slave/test/build 20:25:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:25:48 INFO - Running post-action listener: _resource_record_post_action 20:25:48 INFO - [mozharness: 2016-10-07 03:25:48.295084Z] Finished clobber step (success) 20:25:48 INFO - [mozharness: 2016-10-07 03:25:48.295185Z] Running read-buildbot-config step. 20:25:48 INFO - Running pre-action listener: _resource_record_pre_action 20:25:48 INFO - Running main action method: read_buildbot_config 20:25:48 INFO - Using buildbot properties: 20:25:48 INFO - { 20:25:48 INFO - "project": "", 20:25:48 INFO - "product": "firefox", 20:25:48 INFO - "script_repo_revision": "production", 20:25:48 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 20:25:48 INFO - "repository": "", 20:25:48 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 20:25:48 INFO - "buildid": "20161006202146", 20:25:48 INFO - "stage_platform": "linux64-pgo", 20:25:48 INFO - "basedir": "/builds/slave/test", 20:25:48 INFO - "buildnumber": 291, 20:25:48 INFO - "platform": "ubuntu64_hw", 20:25:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:25:48 INFO - "slavebuilddir": "test", 20:25:48 INFO - "branch": "autoland", 20:25:48 INFO - "revision": "5322af204cb05bea9336b2a500cc65f6a2549575", 20:25:48 INFO - "slavename": "talos-linux64-ix-031", 20:25:48 INFO - "builduid": "5bc7a37d13d34404af75cf50d764fa3d", 20:25:48 INFO - "repo_path": "integration/autoland" 20:25:48 INFO - } 20:25:48 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:25:48 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 20:25:48 INFO - Running post-action listener: _resource_record_post_action 20:25:48 INFO - [mozharness: 2016-10-07 03:25:48.297866Z] Finished read-buildbot-config step (success) 20:25:48 INFO - [mozharness: 2016-10-07 03:25:48.297956Z] Running download-and-extract step. 20:25:48 INFO - Running pre-action listener: _resource_record_pre_action 20:25:48 INFO - Running main action method: download_and_extract 20:25:48 INFO - mkdir: /builds/slave/test/build/tests 20:25: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')]} 20:25:48 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:25:48 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:25:48 INFO - Downloaded 1361 bytes. 20:25:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:25:48 INFO - Using the following test package requirements: 20:25:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:25:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:25:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:25:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:25:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:25:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:25:48 INFO - u'jsshell-linux-x86_64.zip'], 20:25:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:25:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:25:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:25:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:25:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:25:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:25:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:25:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:25:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:25:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:25:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:25:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:25:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:25:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:25:48 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:25:48 INFO - Http code: 200 20:25:48 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 20:25:48 INFO - x-amz-cf-id: Vgsyu3XU-0rBt0fsjjJsiD6VlYbtWSU-587qavCxN8deH-PPhLoKCw== 20:25:48 INFO - x-amz-replication-status: COMPLETED 20:25:48 INFO - x-amz-version-id: 7b8nTnVg2oHrj3_2S9c3mHRArBt2HByQ 20:25:49 INFO - Expected file size: 22017824 20:25:49 INFO - Obtained file size: 22017824 20:25:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:25:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:25:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:25:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:25:53 INFO - Http code: 200 20:25:53 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 20:25:53 INFO - x-amz-cf-id: cRW7kurPSK-sJ6q9QdJA4U6kgkIMS7raLU1EnWEUGtPsru7kBZm5Ww== 20:25:53 INFO - x-amz-replication-status: COMPLETED 20:25:53 INFO - x-amz-version-id: 7b8nTnVg2oHrj3_2S9c3mHRArBt2HByQ 20:25:53 INFO - Expected file size: 22017824 20:25:53 INFO - Obtained file size: 22017824 20:25:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:25:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:25:58 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:25:58 INFO - Http code: 200 20:25:58 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 20:25:58 INFO - x-amz-cf-id: tiK52Asx6FC9ZbP-22nfSm3ZrISXdLNruymzkhm77H9Im4WZG_uz-g== 20:25:58 INFO - x-amz-replication-status: COMPLETED 20:25:58 INFO - x-amz-version-id: CEfgKh2YeXR4_nKKp2IEd68hni4HL3_9 20:25:58 INFO - Expected file size: 14409006 20:25:58 INFO - Obtained file size: 14409006 20:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:58 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:25:58 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:25:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:26:03 INFO - Downloaded 59707070 bytes. 20:26:03 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:26:03 INFO - mkdir: /builds/slave/test/properties 20:26:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:26:03 INFO - Writing to file /builds/slave/test/properties/build_url 20:26:03 INFO - Contents: 20:26:03 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:26:04 INFO - Running post-action listener: _resource_record_post_action 20:26:04 INFO - Running post-action listener: set_extra_try_arguments 20:26:04 INFO - [mozharness: 2016-10-07 03:26:04.366239Z] Finished download-and-extract step (success) 20:26:04 INFO - [mozharness: 2016-10-07 03:26:04.366470Z] Running populate-webroot step. 20:26:04 INFO - Running pre-action listener: _resource_record_pre_action 20:26:04 INFO - Running main action method: populate_webroot 20:26:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:26:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:26:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:26:04 INFO - '--tppagecycles', 20:26:04 INFO - '7'], 20:26:04 INFO - 'tests': ['tsvgm']}}, 20:26:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:26:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:26:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:26:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:26:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:04 INFO - 'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:26:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:26:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:04 INFO - 'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['damp', 'tps']}, 20:26:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:04 INFO - 'tests': ['damp', 'tps']}, 20:26:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['dromaeo_dom']}, 20:26:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:26:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['basic_compositor_video']}, 20:26:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:26:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['a11yr', 20:26:04 INFO - 'ts_paint', 20:26:04 INFO - 'tpaint', 20:26:04 INFO - 'sessionrestore', 20:26:04 INFO - 'sessionrestore_no_auto_restore', 20:26:04 INFO - 'tabpaint']}, 20:26:04 INFO - 'other-e10s': {'tests': ['a11yr', 20:26:04 INFO - 'ts_paint', 20:26:04 INFO - 'tpaint', 20:26:04 INFO - 'sessionrestore', 20:26:04 INFO - 'sessionrestore_no_auto_restore', 20:26:04 INFO - 'tabpaint']}, 20:26:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:26:04 INFO - 'ts_paint', 20:26:04 INFO - 'tpaint', 20:26:04 INFO - 'sessionrestore', 20:26:04 INFO - 'sessionrestore_no_auto_restore', 20:26:04 INFO - 'tabpaint']}, 20:26:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:26:04 INFO - 'ts_paint', 20:26:04 INFO - 'tpaint', 20:26:04 INFO - 'sessionrestore', 20:26:04 INFO - 'sessionrestore_no_auto_restore', 20:26:04 INFO - 'tabpaint']}, 20:26:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['a11yr', 20:26:04 INFO - 'ts_paint', 20:26:04 INFO - 'tpaint', 20:26:04 INFO - 'sessionrestore', 20:26:04 INFO - 'sessionrestore_no_auto_restore', 20:26:04 INFO - 'tabpaint']}, 20:26:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['a11yr', 20:26:04 INFO - 'ts_paint', 20:26:04 INFO - 'tpaint', 20:26:04 INFO - 'sessionrestore', 20:26:04 INFO - 'sessionrestore_no_auto_restore', 20:26:04 INFO - 'tabpaint']}, 20:26:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['tsvgx', 20:26:04 INFO - 'tsvgr_opacity', 20:26:04 INFO - 'tart', 20:26:04 INFO - 'tscrollx', 20:26:04 INFO - 'cart']}, 20:26:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:26:04 INFO - 'tsvgr_opacity', 20:26:04 INFO - 'tart', 20:26:04 INFO - 'tscrollx', 20:26:04 INFO - 'cart']}, 20:26:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:04 INFO - 'talos_options': ['--disable-e10s'], 20:26:04 INFO - 'tests': ['tp5o']}, 20:26:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:04 INFO - 'tests': ['tp5o']}, 20:26:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:04 INFO - 'talos_options': ['--disable-e10s', 20:26:04 INFO - '--xperf_path', 20:26:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:26:04 INFO - 'tests': ['tp5n']}, 20:26:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:04 INFO - 'talos_options': ['--xperf_path', 20:26:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:26:04 INFO - 'tests': ['tp5n']}}, 20:26:04 INFO - 'talos.zip': {'path': '', 20:26:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:26:04 INFO - Running post-action listener: _resource_record_post_action 20:26:04 INFO - [mozharness: 2016-10-07 03:26:04.385631Z] Finished populate-webroot step (success) 20:26:04 INFO - [mozharness: 2016-10-07 03:26:04.385720Z] Running create-virtualenv step. 20:26:04 INFO - Running pre-action listener: _resource_record_pre_action 20:26:04 INFO - Running main action method: create_virtualenv 20:26:04 INFO - Creating virtualenv /builds/slave/test/build/venv 20:26:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:26:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:26:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:26:04 INFO - Using real prefix '/usr' 20:26:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:26:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:26:06 INFO - Installing pip.................done. 20:26:06 INFO - Return code: 0 20:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:26:07 INFO - Reading from file tmpfile_stdout 20:26:07 INFO - Output received: 20:26:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:26:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:26: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')]} 20:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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')]} 20:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26: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', 'pip>=1.5'] in /builds/slave/test/build 20:26: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 pip>=1.5 20:26:07 INFO - Using env: {'DISPLAY': ':0', 20:26:07 INFO - 'HOME': '/home/cltbld', 20:26:07 INFO - 'LANG': 'en_US.UTF-8', 20:26:07 INFO - 'LANGUAGE': 'en_US:en', 20:26:07 INFO - 'LOGNAME': 'cltbld', 20:26:07 INFO - 'MAIL': '/var/mail/cltbld', 20:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:07 INFO - 'MOZ_NO_REMOTE': '1', 20:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:07 INFO - 'NO_EM_RESTART': '1', 20:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:07 INFO - 'PWD': '/builds/slave/test', 20:26:07 INFO - 'SHELL': '/bin/bash', 20:26:07 INFO - 'SHLVL': '1', 20:26:07 INFO - 'TERM': 'linux', 20:26:07 INFO - 'TMOUT': '86400', 20:26:07 INFO - 'USER': 'cltbld', 20:26:07 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:07 INFO - '_': '/tools/buildbot/bin/python'} 20:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:26:07 INFO - Cleaning up... 20:26:07 INFO - Return code: 0 20:26:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:26: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')]} 20:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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')]} 20:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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', '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 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:26: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 psutil>=3.1.1 20:26:07 INFO - Using env: {'DISPLAY': ':0', 20:26:07 INFO - 'HOME': '/home/cltbld', 20:26:07 INFO - 'LANG': 'en_US.UTF-8', 20:26:07 INFO - 'LANGUAGE': 'en_US:en', 20:26:07 INFO - 'LOGNAME': 'cltbld', 20:26:07 INFO - 'MAIL': '/var/mail/cltbld', 20:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:07 INFO - 'MOZ_NO_REMOTE': '1', 20:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:07 INFO - 'NO_EM_RESTART': '1', 20:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:07 INFO - 'PWD': '/builds/slave/test', 20:26:07 INFO - 'SHELL': '/bin/bash', 20:26:07 INFO - 'SHLVL': '1', 20:26:07 INFO - 'TERM': 'linux', 20:26:07 INFO - 'TMOUT': '86400', 20:26:07 INFO - 'USER': 'cltbld', 20:26:07 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:07 INFO - '_': '/tools/buildbot/bin/python'} 20:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:07 INFO - Downloading/unpacking psutil>=3.1.1 20:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:26:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:26:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:26:09 INFO - Installing collected packages: psutil 20:26:09 INFO - Running setup.py install for psutil 20:26:09 INFO - building 'psutil._psutil_linux' extension 20:26:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:26:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:26:10 INFO - building 'psutil._psutil_posix' extension 20:26:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:26:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:26:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:26:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:26:10 INFO - Successfully installed psutil 20:26:10 INFO - Cleaning up... 20:26:10 INFO - Return code: 0 20:26:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:10 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 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:26:10 INFO - Using env: {'DISPLAY': ':0', 20:26:10 INFO - 'HOME': '/home/cltbld', 20:26:10 INFO - 'LANG': 'en_US.UTF-8', 20:26:10 INFO - 'LANGUAGE': 'en_US:en', 20:26:10 INFO - 'LOGNAME': 'cltbld', 20:26:10 INFO - 'MAIL': '/var/mail/cltbld', 20:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:10 INFO - 'MOZ_NO_REMOTE': '1', 20:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:10 INFO - 'NO_EM_RESTART': '1', 20:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:10 INFO - 'PWD': '/builds/slave/test', 20:26:10 INFO - 'SHELL': '/bin/bash', 20:26:10 INFO - 'SHLVL': '1', 20:26:10 INFO - 'TERM': 'linux', 20:26:10 INFO - 'TMOUT': '86400', 20:26:10 INFO - 'USER': 'cltbld', 20:26:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:10 INFO - '_': '/tools/buildbot/bin/python'} 20:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:26:12 INFO - Installing collected packages: mozsystemmonitor 20:26:12 INFO - Running setup.py install for mozsystemmonitor 20:26:12 INFO - Successfully installed mozsystemmonitor 20:26:12 INFO - Cleaning up... 20:26:12 INFO - Return code: 0 20:26:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:12 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 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:26:12 INFO - Using env: {'DISPLAY': ':0', 20:26:12 INFO - 'HOME': '/home/cltbld', 20:26:12 INFO - 'LANG': 'en_US.UTF-8', 20:26:12 INFO - 'LANGUAGE': 'en_US:en', 20:26:12 INFO - 'LOGNAME': 'cltbld', 20:26:12 INFO - 'MAIL': '/var/mail/cltbld', 20:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:12 INFO - 'MOZ_NO_REMOTE': '1', 20:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:12 INFO - 'NO_EM_RESTART': '1', 20:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:12 INFO - 'PWD': '/builds/slave/test', 20:26:12 INFO - 'SHELL': '/bin/bash', 20:26:12 INFO - 'SHLVL': '1', 20:26:12 INFO - 'TERM': 'linux', 20:26:12 INFO - 'TMOUT': '86400', 20:26:12 INFO - 'USER': 'cltbld', 20:26:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:12 INFO - '_': '/tools/buildbot/bin/python'} 20:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:12 INFO - Downloading/unpacking jsonschema==2.5.1 20:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:26:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:14 INFO - Downloading functools32-3.2.3-2.tar.gz 20:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:26:15 INFO - warning: no files found matching '*.txt' 20:26:15 INFO - no previously-included directories found matching 'build' 20:26:15 INFO - no previously-included directories found matching 'dist' 20:26:15 INFO - no previously-included directories found matching '.git*' 20:26:15 INFO - Installing collected packages: jsonschema, functools32 20:26:15 INFO - Running setup.py install for functools32 20:26:15 INFO - warning: no files found matching '*.txt' 20:26:15 INFO - no previously-included directories found matching 'build' 20:26:15 INFO - no previously-included directories found matching 'dist' 20:26:15 INFO - no previously-included directories found matching '.git*' 20:26:15 INFO - Successfully installed jsonschema functools32 20:26:15 INFO - Cleaning up... 20:26:15 INFO - Return code: 0 20:26:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:15 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 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:26:15 INFO - Using env: {'DISPLAY': ':0', 20:26:15 INFO - 'HOME': '/home/cltbld', 20:26:15 INFO - 'LANG': 'en_US.UTF-8', 20:26:15 INFO - 'LANGUAGE': 'en_US:en', 20:26:15 INFO - 'LOGNAME': 'cltbld', 20:26:15 INFO - 'MAIL': '/var/mail/cltbld', 20:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:15 INFO - 'MOZ_NO_REMOTE': '1', 20:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:15 INFO - 'NO_EM_RESTART': '1', 20:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:15 INFO - 'PWD': '/builds/slave/test', 20:26:15 INFO - 'SHELL': '/bin/bash', 20:26:15 INFO - 'SHLVL': '1', 20:26:15 INFO - 'TERM': 'linux', 20:26:15 INFO - 'TMOUT': '86400', 20:26:15 INFO - 'USER': 'cltbld', 20:26:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:15 INFO - '_': '/tools/buildbot/bin/python'} 20:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:26:15 INFO - Cleaning up... 20:26:15 INFO - Return code: 0 20:26:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:15 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 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:26:15 INFO - Using env: {'DISPLAY': ':0', 20:26:15 INFO - 'HOME': '/home/cltbld', 20:26:15 INFO - 'LANG': 'en_US.UTF-8', 20:26:15 INFO - 'LANGUAGE': 'en_US:en', 20:26:15 INFO - 'LOGNAME': 'cltbld', 20:26:15 INFO - 'MAIL': '/var/mail/cltbld', 20:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:15 INFO - 'MOZ_NO_REMOTE': '1', 20:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:15 INFO - 'NO_EM_RESTART': '1', 20:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:15 INFO - 'PWD': '/builds/slave/test', 20:26:15 INFO - 'SHELL': '/bin/bash', 20:26:15 INFO - 'SHLVL': '1', 20:26:15 INFO - 'TERM': 'linux', 20:26:15 INFO - 'TMOUT': '86400', 20:26:15 INFO - 'USER': 'cltbld', 20:26:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:15 INFO - '_': '/tools/buildbot/bin/python'} 20:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:15 INFO - Downloading/unpacking blobuploader==1.2.4 20:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:26:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:26:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:18 INFO - Downloading docopt-0.6.1.tar.gz 20:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:26:18 INFO - Installing collected packages: blobuploader, requests, docopt 20:26:18 INFO - Running setup.py install for blobuploader 20:26:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:26:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:26:18 INFO - Running setup.py install for requests 20:26:18 INFO - Running setup.py install for docopt 20:26:18 INFO - Successfully installed blobuploader requests docopt 20:26:18 INFO - Cleaning up... 20:26:18 INFO - Return code: 0 20:26:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:18 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 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:26:18 INFO - Using env: {'DISPLAY': ':0', 20:26:18 INFO - 'HOME': '/home/cltbld', 20:26:18 INFO - 'LANG': 'en_US.UTF-8', 20:26:18 INFO - 'LANGUAGE': 'en_US:en', 20:26:18 INFO - 'LOGNAME': 'cltbld', 20:26:18 INFO - 'MAIL': '/var/mail/cltbld', 20:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:18 INFO - 'MOZ_NO_REMOTE': '1', 20:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:18 INFO - 'NO_EM_RESTART': '1', 20:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:18 INFO - 'PWD': '/builds/slave/test', 20:26:18 INFO - 'SHELL': '/bin/bash', 20:26:18 INFO - 'SHLVL': '1', 20:26:18 INFO - 'TERM': 'linux', 20:26:18 INFO - 'TMOUT': '86400', 20:26:18 INFO - 'USER': 'cltbld', 20:26:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:18 INFO - '_': '/tools/buildbot/bin/python'} 20:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:26:19 INFO - Running setup.py (path:/tmp/pip-IfBLVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:26:19 INFO - Running setup.py (path:/tmp/pip-4Nxkql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:26:19 INFO - Running setup.py (path:/tmp/pip-P4v0oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:26:19 INFO - Running setup.py (path:/tmp/pip-sVeOG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:26:19 INFO - Running setup.py (path:/tmp/pip-tJHuwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:26:19 INFO - Running setup.py (path:/tmp/pip-wWkIpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:26:19 INFO - Running setup.py (path:/tmp/pip-3yg9o1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:26:19 INFO - Running setup.py (path:/tmp/pip-xoQNxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:26:19 INFO - Running setup.py (path:/tmp/pip-lFigvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:26:19 INFO - Running setup.py (path:/tmp/pip-0xBcQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:26:19 INFO - Running setup.py (path:/tmp/pip-y1M9PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:26:19 INFO - Running setup.py (path:/tmp/pip-40V6hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:26:20 INFO - Running setup.py (path:/tmp/pip-k7qPRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:26:20 INFO - Running setup.py (path:/tmp/pip-ZPihZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:20 INFO - Running setup.py (path:/tmp/pip-Qb3uIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:26:20 INFO - Running setup.py (path:/tmp/pip-6BheZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:26:20 INFO - Running setup.py (path:/tmp/pip-QwJOgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:26:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:26:20 INFO - Running setup.py install for manifestparser 20:26:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:26:20 INFO - Running setup.py install for mozcrash 20:26:20 INFO - Running setup.py install for mozdebug 20:26:20 INFO - Running setup.py install for mozdevice 20:26:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:26:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:26:20 INFO - Running setup.py install for mozfile 20:26:20 INFO - Running setup.py install for mozhttpd 20:26:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Running setup.py install for mozinfo 20:26:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Running setup.py install for mozInstall 20:26:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Running setup.py install for mozleak 20:26:21 INFO - Running setup.py install for mozlog 20:26:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Running setup.py install for moznetwork 20:26:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Running setup.py install for mozprocess 20:26:21 INFO - Running setup.py install for mozprofile 20:26:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Running setup.py install for mozrunner 20:26:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:26:21 INFO - Running setup.py install for mozscreenshot 20:26:22 INFO - Running setup.py install for moztest 20:26:22 INFO - Running setup.py install for mozversion 20:26:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:26:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:26:22 INFO - Cleaning up... 20:26:22 INFO - Return code: 0 20:26:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:22 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 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:26:22 INFO - Using env: {'DISPLAY': ':0', 20:26:22 INFO - 'HOME': '/home/cltbld', 20:26:22 INFO - 'LANG': 'en_US.UTF-8', 20:26:22 INFO - 'LANGUAGE': 'en_US:en', 20:26:22 INFO - 'LOGNAME': 'cltbld', 20:26:22 INFO - 'MAIL': '/var/mail/cltbld', 20:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:22 INFO - 'MOZ_NO_REMOTE': '1', 20:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:22 INFO - 'NO_EM_RESTART': '1', 20:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:22 INFO - 'PWD': '/builds/slave/test', 20:26:22 INFO - 'SHELL': '/bin/bash', 20:26:22 INFO - 'SHLVL': '1', 20:26:22 INFO - 'TERM': 'linux', 20:26:22 INFO - 'TMOUT': '86400', 20:26:22 INFO - 'USER': 'cltbld', 20:26:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:22 INFO - '_': '/tools/buildbot/bin/python'} 20:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:26:22 INFO - Running setup.py (path:/tmp/pip-T_Jp9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:26:22 INFO - Running setup.py (path:/tmp/pip-8C6IZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:26:22 INFO - Running setup.py (path:/tmp/pip-fxExeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:26:22 INFO - Running setup.py (path:/tmp/pip-k6ZQTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:26:22 INFO - Running setup.py (path:/tmp/pip-DjOA28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:26:22 INFO - Running setup.py (path:/tmp/pip-TCT8RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:26:22 INFO - Running setup.py (path:/tmp/pip-aZPUjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:26:22 INFO - Running setup.py (path:/tmp/pip-ty_PFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:26:23 INFO - Running setup.py (path:/tmp/pip-CN9GRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:26:23 INFO - Running setup.py (path:/tmp/pip-Czt1r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:26:23 INFO - Running setup.py (path:/tmp/pip-nvCG8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:26:23 INFO - Running setup.py (path:/tmp/pip-7zjfeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:26:23 INFO - Running setup.py (path:/tmp/pip-cvr4L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:26:23 INFO - Running setup.py (path:/tmp/pip-Wk_2EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:23 INFO - Running setup.py (path:/tmp/pip-6a16ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:26:23 INFO - Running setup.py (path:/tmp/pip-Hgk7lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:26:23 INFO - Running setup.py (path:/tmp/pip-fmzTpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:26:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:25 INFO - Downloading blessings-1.6.tar.gz 20:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:26:25 INFO - Installing collected packages: blessings 20:26:25 INFO - Running setup.py install for blessings 20:26:25 INFO - Successfully installed blessings 20:26:25 INFO - Cleaning up... 20:26:25 INFO - Return code: 0 20:26:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:26:26 INFO - Reading from file tmpfile_stdout 20:26:26 INFO - Current package versions: 20:26:26 INFO - argparse == 1.2.1 20:26:26 INFO - blessings == 1.6 20:26:26 INFO - blobuploader == 1.2.4 20:26:26 INFO - docopt == 0.6.1 20:26:26 INFO - functools32 == 3.2.3-2 20:26:26 INFO - jsonschema == 2.5.1 20:26:26 INFO - manifestparser == 1.1 20:26:26 INFO - mozInstall == 1.12 20:26:26 INFO - mozcrash == 0.17 20:26:26 INFO - mozdebug == 0.1 20:26:26 INFO - mozdevice == 0.48 20:26:26 INFO - mozfile == 1.2 20:26:26 INFO - mozhttpd == 0.7 20:26:26 INFO - mozinfo == 0.9 20:26:26 INFO - mozleak == 0.1 20:26:26 INFO - mozlog == 3.4 20:26:26 INFO - moznetwork == 0.27 20:26:26 INFO - mozprocess == 0.23 20:26:26 INFO - mozprofile == 0.28 20:26:26 INFO - mozrunner == 6.12 20:26:26 INFO - mozscreenshot == 0.1 20:26:26 INFO - mozsystemmonitor == 0.3 20:26:26 INFO - moztest == 0.7 20:26:26 INFO - mozversion == 1.4 20:26:26 INFO - psutil == 3.1.1 20:26:26 INFO - requests == 1.2.3 20:26:26 INFO - wsgiref == 0.1.2 20:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:26 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 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:26:26 INFO - Using env: {'DISPLAY': ':0', 20:26:26 INFO - 'HOME': '/home/cltbld', 20:26:26 INFO - 'LANG': 'en_US.UTF-8', 20:26:26 INFO - 'LANGUAGE': 'en_US:en', 20:26:26 INFO - 'LOGNAME': 'cltbld', 20:26:26 INFO - 'MAIL': '/var/mail/cltbld', 20:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:26 INFO - 'MOZ_NO_REMOTE': '1', 20:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:26 INFO - 'NO_EM_RESTART': '1', 20:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:26 INFO - 'PWD': '/builds/slave/test', 20:26:26 INFO - 'SHELL': '/bin/bash', 20:26:26 INFO - 'SHLVL': '1', 20:26:26 INFO - 'TERM': 'linux', 20:26:26 INFO - 'TMOUT': '86400', 20:26:26 INFO - 'USER': 'cltbld', 20:26:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:26 INFO - '_': '/tools/buildbot/bin/python'} 20:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:26:26 INFO - Cleaning up... 20:26:26 INFO - Return code: 0 20:26:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd023768f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:26:26 INFO - Using env: {'DISPLAY': ':0', 20:26:26 INFO - 'HOME': '/home/cltbld', 20:26:26 INFO - 'LANG': 'en_US.UTF-8', 20:26:26 INFO - 'LANGUAGE': 'en_US:en', 20:26:26 INFO - 'LOGNAME': 'cltbld', 20:26:26 INFO - 'MAIL': '/var/mail/cltbld', 20:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:26 INFO - 'MOZ_NO_REMOTE': '1', 20:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:26 INFO - 'NO_EM_RESTART': '1', 20:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:26 INFO - 'PWD': '/builds/slave/test', 20:26:26 INFO - 'SHELL': '/bin/bash', 20:26:26 INFO - 'SHLVL': '1', 20:26:26 INFO - 'TERM': 'linux', 20:26:26 INFO - 'TMOUT': '86400', 20:26:26 INFO - 'USER': 'cltbld', 20:26:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:26 INFO - '_': '/tools/buildbot/bin/python'} 20:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:26:26 INFO - Cleaning up... 20:26:26 INFO - Return code: 0 20:26:26 INFO - Running post-action listener: _resource_record_post_action 20:26:26 INFO - Running post-action listener: _start_resource_monitoring 20:26:26 INFO - Starting resource monitoring. 20:26:26 INFO - [mozharness: 2016-10-07 03:26:26.530917Z] Finished create-virtualenv step (success) 20:26:26 INFO - [mozharness: 2016-10-07 03:26:26.531425Z] Running install step. 20:26:26 INFO - Running pre-action listener: _resource_record_pre_action 20:26:26 INFO - Running main action method: install 20:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:26:26 INFO - Reading from file tmpfile_stdout 20:26:26 INFO - Detecting whether we're running mozinstall >=1.0... 20:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:26:26 INFO - Reading from file tmpfile_stdout 20:26:26 INFO - Output received: 20:26:26 INFO - Usage: mozinstall [options] installer 20:26:26 INFO - Options: 20:26:26 INFO - -h, --help show this help message and exit 20:26:26 INFO - -d DEST, --destination=DEST 20:26:26 INFO - Directory to install application into. [default: 20:26:26 INFO - "/builds/slave/test"] 20:26:26 INFO - --app=APP Application being installed. [default: firefox] 20:26:26 INFO - mkdir: /builds/slave/test/build/application 20:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:26:43 INFO - Reading from file tmpfile_stdout 20:26:43 INFO - Output received: 20:26:43 INFO - /builds/slave/test/build/application/firefox/firefox 20:26:43 INFO - Running post-action listener: _resource_record_post_action 20:26:43 INFO - [mozharness: 2016-10-07 03:26:43.833500Z] Finished install step (success) 20:26:43 INFO - [mozharness: 2016-10-07 03:26:43.833840Z] Running run-tests step. 20:26:43 INFO - Running pre-action listener: _resource_record_pre_action 20:26:43 INFO - Running main action method: run_tests 20:26:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:26:43 INFO - Python 2.7.3 20:26:43 INFO - Return code: 0 20:26:43 INFO - grabbing minidump binary from tooltool 20:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:43 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 0x23c5930>, '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 0x23c6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:26:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:26:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:26:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:26:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:26:43 INFO - Return code: 0 20:26:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:26:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:26:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:26:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:26:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:26:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:26:43 INFO - Using env: {'DISPLAY': ':0', 20:26:43 INFO - 'HOME': '/home/cltbld', 20:26:43 INFO - 'LANG': 'en_US.UTF-8', 20:26:43 INFO - 'LANGUAGE': 'en_US:en', 20:26:43 INFO - 'LOGNAME': 'cltbld', 20:26:43 INFO - 'MAIL': '/var/mail/cltbld', 20:26:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:26:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:43 INFO - 'MOZ_NO_REMOTE': '1', 20:26:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:43 INFO - 'NO_EM_RESTART': '1', 20:26:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:43 INFO - 'PWD': '/builds/slave/test', 20:26:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:26:43 INFO - 'SHELL': '/bin/bash', 20:26:43 INFO - 'SHLVL': '1', 20:26:43 INFO - 'TERM': 'linux', 20:26:43 INFO - 'TMOUT': '86400', 20:26:43 INFO - 'USER': 'cltbld', 20:26:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935', 20:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:43 INFO - '_': '/tools/buildbot/bin/python'} 20:26:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:26:44 INFO - mozversion application_buildid: 20161006183001 20:26:44 INFO - mozversion application_changeset: 5322af204cb05bea9336b2a500cc65f6a2549575 20:26:44 INFO - mozversion application_display_name: Nightly 20:26:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:26:44 INFO - mozversion application_name: Firefox 20:26:44 INFO - mozversion application_remotingname: firefox 20:26:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:26:44 INFO - mozversion application_vendor: Mozilla 20:26:44 INFO - mozversion application_version: 52.0a1 20:26:44 INFO - mozversion platform_buildid: 20161006183001 20:26:44 INFO - mozversion platform_changeset: 5322af204cb05bea9336b2a500cc65f6a2549575 20:26:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:26:44 INFO - mozversion platform_version: 52.0a1 20:26:44 INFO - using testdate: 1475810804 20:26:44 INFO - actual date: 1475810804 20:26:44 INFO - starting webserver on 'localhost:39624' 20:26:44 INFO - SUITE-START | Running 2 tests 20:26:44 INFO - TEST-START | dromaeo_css 20:26:44 INFO - operating with platform_type : linux_ 20:26:44 INFO - Initialising browser for dromaeo_css test... 20:26:44 INFO - TEST-INFO | started process 800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7QJpw/profile http://localhost:39624/getInfo.html) 20:26:48 INFO - PROCESS | 800 | __metrics Screen width/height:1600/1200 20:26:48 INFO - PROCESS | 800 | colorDepth:24 20:26:48 INFO - PROCESS | 800 | Browser inner width/height: 1024/697 20:26:48 INFO - PROCESS | 800 | __metrics 20:26:49 ERROR - PROCESS | 800 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 20:26:50 INFO - TEST-INFO | 800: exit 0 20:26:50 INFO - Browser initialized. 20:26:50 INFO - Running cycle 1/1 for dromaeo_css test... 20:26:50 INFO - TEST-INFO | started process 929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7QJpw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:27:02 INFO - PROCESS | 929 | RSS: Main: 184348672 20:27:02 INFO - PROCESS | 929 | 20:27:52 INFO - PROCESS | 929 | 1475810872047 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:30:02 INFO - PROCESS | 929 | Cycle 1(1): loaded http://localhost:39624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39624/tests/dromaeo/cssquery-ext.html) 20:30:04 INFO - PROCESS | 929 | RSS: Main: 201461760 20:30:04 INFO - PROCESS | 929 | 20:33:06 INFO - PROCESS | 929 | Cycle 1(1): loaded http://localhost:39624/tests/dromaeo/cssquery-ext.html (next: http://localhost:39624/tests/dromaeo/cssquery-jquery.html) 20:33:06 INFO - PROCESS | 929 | RSS: Main: 203505664 20:33:06 INFO - PROCESS | 929 | 20:36:08 INFO - PROCESS | 929 | Cycle 1(1): loaded http://localhost:39624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39624/tests/dromaeo/cssquery-mootools.html) 20:36:09 INFO - PROCESS | 929 | RSS: Main: 204644352 20:36:09 INFO - PROCESS | 929 | 20:39:11 INFO - PROCESS | 929 | Cycle 1(1): loaded http://localhost:39624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39624/tests/dromaeo/cssquery-prototype.html) 20:39:12 INFO - PROCESS | 929 | RSS: Main: 198209536 20:39:12 INFO - PROCESS | 929 | 20:42:14 INFO - PROCESS | 929 | Cycle 1(1): loaded http://localhost:39624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39624/tests/dromaeo/cssquery-yui.html) 20:42:15 INFO - PROCESS | 929 | RSS: Main: 200916992 20:42:15 INFO - PROCESS | 929 | 20:45:17 INFO - PROCESS | 929 | Cycle 1(1): loaded http://localhost:39624/tests/dromaeo/cssquery-yui.html (next: http://localhost:39624/tests/dromaeo/cssquery-dojo.html) 20:45:18 INFO - PROCESS | 929 | RSS: Main: 200507392 20:45:18 INFO - PROCESS | 929 | 20:45:18 INFO - PROCESS | 929 | __start_tp_report 20:45:18 INFO - PROCESS | 929 | _x_x_mozilla_page_load 20:45:18 INFO - PROCESS | 929 | _x_x_mozilla_page_load_details 20:45:18 INFO - PROCESS | 929 | |i|pagename|runs| 20:45:18 INFO - PROCESS | 929 | |0;dojo.html;3052.8015678980864;3071.9539206911886;3089.2894634234126;3090.2737856603694;3106.953395699065;5250.737463126848;5292.073887069761;5364.490373414519;5379.9731001344935;5395.325584301962;5315.760790764415;5340.893182136355;5395.0558652235795;5433.891322173554;5487.670739755617;4817.205161148407;4935.901281974358;4945.752712364368;4947.18371468709;4972.825951091712;4862.17343051682;4902.264660300948;4906.215005599105;4924;4976.925346119811;4701.764911754399;4703.318018887242;4755.690880092783;4832.855014349575;4872.439669438007;4782.641301902337;4833.879153021167;4854.587360074398;4903.043906438246;4908.901821963576;4765.428148622187;4804.615630749532;4815.855524334275;4831.4685384607665;4878.243872199815;5151.742412879341;5179.974100129513;5281.128613778722;5303.5226829585135;5388.461153884619;5640.266765320482;5649.548036157139;5724.484796368347;5770.88458230833;5776.075827867563;5640.605157638967;5665.093585026417;5672.914906276409;5678.063119585305;5727.11229759388;5340.626156169031;5360.249565060894;5371.704556249405;5381.569474442035;5431.701256430855;5887.676177810262;5952.136940143741;5962.701864906824;5973.910391344133;6037.396260373927;5676.971615141898;5736.168255602997;5737.741801618937;5743.8564035899435;5744.798932037359;5635.239242702182;5743.396943320891;5794.82615521535;5828.388019258002;5830.4461076197695;5793.333766616809;5796.246487956623;5801.448862358069;5805.970970145122;5865.618734782225;5796.681182535001;5800.361960184377;5806.796762113306;5813.7383817728305;5815.534757219412;4363;4375.409319741858;4410.889727756768;4479.955200448019;4533;3872.3997780344093;3902.161035377351;3944.1322908959983;3959.920801583952;3968.7420317679257;5333.466653334635;5365.490278423544;5378.757955891916;5383.380911195184;5386.434424385461;5646.745896434671;5648.435156484319;5681.375048744718;5685.1756495307945;5689.800856970069;5441.673499590037;5469;5503.229547863302;5513.531349835309;5539.529140023144;4991.226359914219;4991.925121123186;4997.675151115166;5000.924986125211;5053;5954;5985.521158307412;5993.760249590055;6009.549283803733;6023.216981792339;5798.913016304675;5817.040188368872;5836.445537673914;5848.093545500455;5907.4683278505145;5951.910721339097;5957.91063134062;5965.403459654173;5985.281766188085;6022.1870047543025;5350.2242174885205;5418.295621569171;5676.2337084493065;5689.402612725604;5723.971380143073;5782.248307720138;5827.679477628772;5836;5861.35525092248;5939.465448109518;5635.971820140873;5637.182608521824;5639.689817060101;5650.85872853182;5669.4047125051275;5523.171524271392;5651.604387692986;5675.858103547279;5689.260396148474;5709.857253568694;5524.889502209853;5531.585131115102;5586.38549759518;5609.775608975759;5615.6630602164005;5681;5733.627314224562;5749.195112684144;5758.596898217253;5813.186153938367;5571.916421253765;5578.776848925998;5615.691136987505;5618.157276408408;5621.634593751393 20:45:18 INFO - PROCESS | 929 | |1;ext.html;576.0782747603835;576.1789450033701;588.3293045927641;591.2018774654217;591.9079298693911;41932.37101443477;43925.34111988319;43969.12061758763;47588.76205618967;47685;44963.55036449643;45345.31982020264;45366;45480;45500.08999820002;8726.301895848334;8834.602442890053;8871.733847984571;8873.29013678904;8900.866487002668;8721.345899057564;8724.651013959434;8763.912360876373;8767.386282960164;8808.339374546935;8755.605997730117;8763.430377025505;8796.736097917073;8797.164269394429;8831.425957312786;8745.212930836224;8745.431546949429;8779.78050548735;8790.824183516293;8791.692290769824;8549.957250213709;8561.614727337284;8593.355498337649;8595.796588477619;8599.269062129726;42475.36286955698;42967;43011.35482967758;43093.35359969603;43128.78435607802;3608.8015159166234;3629.8548058077645;3807.8857634271017;4045.554988951213;4186.413902053715;31268.37463250745;31458.37083258345;31639;31684.841575791972;32581.83709081463;4252.766097864616;4317.460317460317;4349.086691794727;4355.041890784022;4442.444694413199;346748;347094;347852;348182;348304;56959;57556.13665795016;57624.423755761905;57669.711651441474;57689.711551442815;59203;59348.703256483444;59659.70170149121;59690.403095969355;59915.400845991855;16164.595885102966;16352.672946541003;16484.917575412048;16485.91757041207;16519.174041297887;12457.563985260473;12460;12462.189957652723;12488.313142777235;12515.74968500643;15208.847911520965;16172.353105875869;16380.180990950405;16412.261448234618;16542;5652.236948011966;5828.79599214034;5837.357890632027;5866.853328666817;5943;895.6193617712446;1026.2867307221409;1098.5386137822134;1125.1954852280658;1130.6268931252666;28680.71319286822;29208.26979325534;30172.491375431142;30533.236669083006;31308.843455782575;1093.2893619147617;1105.5190991918541;1112.6606385052476;1130.1975597325827;1136.9033632141195;15864.762028569581;15959.601009974844;16190.514284571482;16370.590735231715;16535.751963720555;509690;514356;516603.2547558948;517872;518404;55548.72225638846;56353;56570;56894.43105568974;56922.43077569254;1212.7998880184848;1268.321448025302;1276.7446510698082;1283.1402960016624;1317.2096741954751;28788.280292992844;29724.554131687608;30628.08115756531;30632.540511892785;30955.69044309528;49848.252276215164;50062.249066263306;50283.24575131303;50318;50440;426057;426175;428939;430316;430480;39578.60421395749;39687.60312396839;39740.03249593801;39922;39923.201535969696;44737;45385.319220211066;45451.31823022591;46575.30137048015;49839.50160498349;39119.60880391159;40250.59749402468;40488.1902361957;40760.79619601883;41611.7919410401;40560.18879622332;41290.79354603208;41321;41607.16785664209;42610.57389426066;38405.423918640685;39337.40993885151;39586.604133958295;39704.404433932934;42770.35844462273;30753.846230768704;34597;35932.64067359293;36140;36395.27209455743;26920.730792691822;27075.458490830468;27098.1870543884;27110.32224194332;27504 20:45:18 INFO - PROCESS | 929 | |2;jquery.html;390.3364280722772;402.63963752441583;409.63951722484217;410.3741793764508;418.03851142372554;16051.678966420664;16119.355225790983;17621.11894405281;19069.237230510782;19297.61404771904;12390.566330178446;13085.738285234289;13137.080404371674;16044.83955160448;19272;5266.3943646480575;5460.235567020621;5490.670559766407;5491.423400542945;5497.532709719659;5504.80733174339;5765.769369225247;5824.0390335594575;5891.234139561851;5893.7347819348015;5663.603547751659;5877.794277200299;6013.067974463965;6016.518678505709;6032.457078862902;5982.401759824026;5987.520998320124;6022.397760223965;6022.698865056752;6281.780137695205;5823.388544202882;5841.503472204868;5850.64896106235;5880.70596470179;5891.558133140032;15692.68614627701;22235;22409.439764005867;22632.547349053093;22635.320940371814;2319.756425575324;2323.9535209295886;2357.316378250305;2375.8099352051795;2392.605220138675;9951.154151897097;10136.074145912327;10190.796184076276;10823.188260880466;10898.618548350769;1867.4864412286595;1914.0238478375989;1971.0637447212603;1982.266561372287;2012.8289095426906;73107.63446182788;74923.62538187274;75874.24125758727;89696.55151724265;89823;11005.284656497302;11266.493007814668;11343.319400835977;11419.942900285445;11685.76628467443;16037;16070.43753468623;16077;16158.27287772053;16185.352585896668;7238.384737297283;7399.149097853816;7437.888431673529;7547.886781698279;7553.433492488085;6645.700943457459;6707.564008339442;6874.862502749917;6904.067950826675;6931.707438966551;4677.18149323867;4759.4764575896625;4803.975980120077;4805.423349198119;4948.4309304429735;1902.6194761047846;1947.7078438234378;1987.2547794577033;2013.1947221111673;2074.512489564951;868.2793281576277;942.4204114469552;955.1594596754811;964.9662261820943;1007.4106647611083;18176.727349089775;19247.711284330748;19408.80591194098;19433.805661943483;19453.47104876357;959.9088086631759;975.6292608808608;983.3165949665057;995.4077323992213;1027.1474676018886;10190;10750;10807.729806754895;10841.891581084246;10865.40240286776;443990;449844;454473;456436.5890852689;458500;89136;90058.54970725236;90060;91330;92682;956.4261443134203;969.6024629901707;1005.8583507718791;1007.3955626624113;1016.6035246253966;15886.68226635484;16225.51323460298;16466.176691165634;16864.409745658842;17442.21510032077;39178.80410597929;39548;39657.20685586215;40125.398119028825;40152.59847401606;52934.47065529296;56784.716076419354;57086;58453.415465844795;58585.70707146607;8485.95757021211;8528.829423411373;8576.485410875368;8605.569721514024;8767.780805479659;11406.315621062762;12829.61511154667;12878.227306361649;12893.806592901301;13062.54281100157;10540.209484288556;11051.281666691639;11632.651020469399;11792.351420671945;11808;10950.233483656068;11103.833442498208;11115.610953616584;11260;11276.436178191221;10708.62519811834;10875.129989600971;11610.129240306842;11639.43932334885;11644.767104658029;8360.331173505983;8400.789980250544;8668.393212475066;8670.523121228392;8675.262602678842;10235.590576376862;10782.946085269523;10871.67384978452;10924.836127458253;11474.598389056342 20:45:18 INFO - PROCESS | 929 | |3;mootools.html;1446.8263808343002;1484.1985327922923;1627.454802641115;1726.6891959447294;1734.6443978984316;7889.408294377916;8159.061707903593;8460.153984601544;9051.411658242218;9080.727578172657;8452.366072544553;8817.867731984026;8818.338624603164;9075.500847453388;9095.681651142211;2305.4927915858484;2314.872682002489;2340.8361414700976;2343.16817529777;2361.0437772702;2320.7679232076744;2329.4642232286583;2400.987995060022;2401.0395841663385;2402.615581506959;2316.247219653611;2320.3503019154577;2330;2395.3053614451787;2398.8080953523763;2297.5060362022245;2298.9885050574726;2309.2379514760087;2309.3764683535437;2357.116081469449;2309.6881920940796;2316.7104111986;2323.256557901472;2323.4772176260376;2336.5210131923086;9069.501177435239;9073.228775554086;9132.99537050924;9163.266938644892;9195.540222988891;5185.455527169668;5247.344081989751;5292.153255479105;5382.273393091921;5409.323834520685;3343.147497388175;3472.58329000519;3511.9122021949656;3514.2795726876184;3563.0379797454543;1147.7245461089362;1177.6937996120985;1190.4107466803987;1192.7375977284983;1193.7194759231575;12405.193662411913;12482.563110291187;12529.872311491918;12538.498460061586;12596.307203103826;4502.099580083996;4587.4036375271;4698.073857150463;4740.1230772307235;4865.343178670834;10466.790664186674;10491.895081049244;10507.842382364272;10551.788964220672;10568.788624227625;5366.409694933554;5366.892662146735;5369.704666243316;5371.838844834661;5377.139657654757;4356.259435895905;4504;4810;4923.458419573844;4980.7509624518625;3946.506686664167;4054.493188351456;4131.814068366931;4154.189932963043;4166.958330416657;1278.4310981613094;1298.7077907470743;1301.7982212757038;1312.5799744081803;1328.5682153300022;964.768455570672;965.5944503308627;991.375433476905;996.8205722969935;1013.5894962540183;6009.579329446897;6098.69506524672;6100.633961962297;6145.201123853871;6161.44546990773;460.55386087684695;466.9813207471663;470.407286818611;479.59474244263544;481.6195205787459;4000.139969906484;4082.7142100053306;4159.313713237342;4219.578042195817;4237.703360764717;10977.725556861142;11223.102151827834;11323.886761132284;11331.32012079278;11337.659870203906;11025.669229923114;11213.551457941754;11220.102391808636;11231.775364492827;11243;8226.876596851052;8311.459755116019;8324.833503329899;8332.833343333221;8347.248747612623;5842.006858834094;5863;5929.6145750526075;5973.193618861398;6009.639421634716;10030.348027378197;10144.695659130239;10152.847707284544;10330.638427654996;10346.017128372792;10415.218858585486;10575.206859485415;10593.2584719072;10602.25784195099;10605.575776969143;7145.4998150128995;7372.96313518429;7920.207979202034;7989.480683755537;7993.640286187252;8133.0646975598565;8382.287505562095;8459.957700211706;8605.784855378666;8754.824903501767;7620.8475830484185;7644;7699.923000769921;7774.572398518136;7992.440529163136;7411.444141689502;7446.8510629786015;7454.366378857858;7668.501547399401;7705.460617756703;6877.1747390313485;6967.512274140761;6984.26665200167;6994.300569942965;7008.439324854102;4910.06708725341;5005.799768009385;5014.974925125351;5120.948790512047;5202.193659982709;5009.474005229398;5083.898322033612;5164.561012313995;5218.739063046756;5238.947610523846 20:45:18 INFO - PROCESS | 929 | |4;prototype.html;322.5307178055929;331.87720543398945;332.51452878796954;334.05629097798715;345.63017571198793;5355.3305836770405;5456.208849716789;5457.781688732456;5540.196671482638;5544.223808666785;5183.496785932075;5394.8921021579545;5435.456454354563;5437.673739575628;5460.399356070839;4263.126059157865;4266.863855066524;4279.72181808183;4284.721493102954;4297.892552686177;4131;4239.258129827268;4254.595813397722;4295;4300.22595932732;4208.389783481393;4220.831166753326;4222.683298752606;4237.555056719047;4247.895547157746;4209.6000879916355;4246.171996460692;4263.957360426402;4274.123804620045;4299.269124248885;3749.9625003749884;3825.3114439400897;3830.5020347354944;3838.366669499529;3840.135969406861;5300.575953923715;5304.761285742151;5346.304980352568;5362.195670649395;5391.245225668409;4929.75351232437;4941.629377796644;4942.654014219006;4943.6539442239055;4964.90070198594;5432.641839540115;5690.715464226772;5695.974724549579;5712.6286791358425;5776.740046697867;4123.154753275601;4127.40152677863;4146.958530414688;4149.33610622299;4165.562615925345;5952.821415357546;5978.8505287367725;5979.730912108966;5981.700914954235;6005.339412664647;3916.784576848244;4120.320147175682;4258.127083947783;4281.657467402601;4292.120115376403;4162.354835000579;4197.97901010493;4206.11671548972;4213.494380674339;4236.872893813191;4827.8551643450755;4828.299896514985;4835.685680430761;4842.927356089662;4853.12643724126;5566.749496272678;5713.942860571424;5765.942340576625;5855.853603659857;5867.765289388462;1434.2255182201702;1448.5364683301243;1455.163281113364;1458.4385011770544;1459.7883756482095;887.7159309021051;896.2695403246464;927.4157280913116;931.8881734191805;940.3276657190141;4826.817429729668;4841;4856.635752318591;4872.585830204402;4903.289023091632;5103.464136265713;5167.896642067138;5185.351831021122;5202.167653175549;5207.92188117171;4761;4785.320220676433;4851.757412129379;4881.609471242292;4885.389326334208;2736.6305548750665;2753.9449211015667;2754.311422144464;2765.9446811064067;2768.9307767305977;5325.254464374991;5327.413984461706;5329.546988505943;5331.306930099062;5342.305500284938;5088.821891233789;5205.323307969939;5264.973675131677;5293.682379057269;5325.360956685223;5314.7874085036165;5331.413544510101;5354.8487075279;5372.892542149135;5378.300820893259;5122.334096567572;5139.331886854685;5180.5494461550825;5204.687718736888;5215.843524694265;4764.331974094518;4904.313396124474;5108.59131269505;5121.180611102206;5135.717535535432;5245.246245721027;5378.838634840961;5388.464287677993;5403.9459605403445;5406.350888064899;3845.9615403845605;3959.7030222732833;4036.313826649418;4095.6928230383437;4149.792510374409;5798.478136967693;5829.300483941955;5829.883402332014;5836;5876.647401155944;5601.011640867433;5701.543876489788;5728.2266893970445;5748.310202775694;5774.105013722712;5660.782931669711;5672.440078978314;5681.375048744552;5699.401562835843;5705.942940570541;5578.49793518569;5620.747066382104;5634.943650563442;5640.379558248672;5657.377688454185;5539.418361072029;5641.464060914206;5668.461496157858;5712.943340397536;5757.596968212185;5563.833085007456;5565.526930210977;5586.664800112007;5593.944060559343;5628.324601047901 20:45:18 INFO - PROCESS | 929 | |5;yui.html;703.7009271059799;705.8059033765713;749.1160430691789;754.8414832885094;812.4678335690123;15819.762703559441;16708.582285442855;16715.080670563115;16717.414890478834;16725;15051;15201;15203.54389368318;15283.770743438858;15343.079415235094;768.8577613141558;788.8737801951689;791.6556298010383;797.7048492057946;797.8444203380343;776.130733578393;780.910195327536;781.9765407037798;782.659543098751;784.4548039112819;814.8940637717088;821.7411515372669;823.6005537314397;825.9256666899978;826.1490664615455;816.5917041479261;823.4400607586839;824.3240542754943;824.4352618456377;825.0635528674967;606.6087373644019;611.1749138662814;612.8866159760458;614.0727501472763;614.3610644929269;12284.631461056093;12290.078244131637;12298.508059677602;12307.384630768425;12318.260904345769;12694.746105077938;13172.934135329358;13361.077428980612;13388.456193323238;13561.86438135616;9678.806423871483;9749.902500974971;9943.254255930762;9973.501324933724;10407.583696652126;3670.944935825965;3713.4801127842125;3742.101895545077;3782.451544526028;4017.5982401759884;70322.64838675826;70616;71197.64401177962;71559.64220178917;75255;9560.749245675644;9748.46383448903;9789.657361992297;9921.454320012324;9921.851172232422;19492.31776887802;19683.311084112273;19758.70361944572;19829.4051178462;20192.798072019094;7880.527168369917;7992.920070799334;7993.521198578282;8087.676492940334;8107.959460202661;4389.956100439019;4508.391367165456;4631.096936097429;4722.645801564828;4732.479427262998;3695.4826324314618;3782.7541209821275;3802.6387493188104;3808.352580061396;3828.789416582115;646.9708863101172;666.7299743603849;669.0399277037467;669.88611935971;681.5876394781185;706.8056284521798;719.3274288540232;731.1920328037442;746.7423738810102;763.8357753083113;8842.115788421235;9057.909420905838;9216;9538.904610953941;9645.662401815904;595.2886300870505;674.2414783368711;718.4396170986639;720.2365492577884;738.0368618952211;4060.837566497307;4363.2582460981075;4649.721016739007;4737.857864264078;4757.429108507002;93856;95758.52120739351;98004;123982;127934;85289.57355213308;95700;95744.52127739455;97363;97606.51196744113;54785;81353.77969330465;81912.18087819165;85689.57155214308;85726.57136714277;9185.265178785547;9453.291003174652;9561.474118923526;9650.179734722627;9690.12788849007;50530.74734626304;50761.74619126881;50998.490015100855;51819.481805181465;52390.738046309525;69049.30950690429;75378;77294.61352693201;79872.60063699645;80674.19325806666;12018.399080046138;12083.758324833278;12198.085143614442;12573.748525029265;13644.863551364757;13470.865291346961;13711.546144626687;14156.858431415554;14172.50396236168;14622.926885365505;13242.867571324163;13502.797458038334;13525.458981640624;13773.311334433038;13909.165450073027;13237.536686215935;13425.194488330731;13864.584062478141;14346.139231646135;14571.854281457474;12237.204581702517;12334.444949977093;12452.937735311265;13064.869351306745;13273.734525309246;10193.74515637115;10618.415987120474;10738.248322617343;10754.462276885968;11267.492962816857;9786.217102631916;10840.728981775203;10846.891531084904;10885.727856803644;10899.836502452628 20:45:18 INFO - PROCESS | 929 | __end_tp_report 20:45:18 INFO - PROCESS | 929 | __start_cc_report 20:45:18 INFO - PROCESS | 929 | _x_x_mozilla_cycle_collect,320 20:45:18 INFO - PROCESS | 929 | __end_cc_report 20:45:18 INFO - PROCESS | 929 | __startTimestamp1475811918236__endTimestamp 20:45:18 INFO - PROCESS | 929 | 20:45:18 INFO - PROCESS | 929 | ------- Summary: start ------- 20:45:18 INFO - PROCESS | 929 | Number of tests: 6 20:45:18 INFO - PROCESS | 929 | 20:45:18 INFO - PROCESS | 929 | [#0] dojo.html Cycles:165 Average:5350.21 Median:5586.39 stddev:622.70 (11.1%) stddev-sans-first:597.96 20:45:18 INFO - PROCESS | 929 | Values: 3052.8 3072.0 3089.3 3090.3 3107.0 5250.7 5292.1 5364.5 5380.0 5395.3 5315.8 5340.9 5395.1 5433.9 5487.7 4817.2 4935.9 4945.8 4947.2 4972.8 4862.2 4902.3 4906.2 4924.0 4976.9 4701.8 4703.3 4755.7 4832.9 4872.4 4782.6 4833.9 4854.6 4903.0 4908.9 4765.4 4804.6 4815.9 4831.5 4878.2 5151.7 5180.0 5281.1 5303.5 5388.5 5640.3 5649.5 5724.5 5770.9 5776.1 5640.6 5665.1 5672.9 5678.1 5727.1 5340.6 5360.2 5371.7 5381.6 5431.7 5887.7 5952.1 5962.7 5973.9 6037.4 5677.0 5736.2 5737.7 5743.9 5744.8 5635.2 5743.4 5794.8 5828.4 5830.4 5793.3 5796.2 5801.4 5806.0 5865.6 5796.7 5800.4 5806.8 5813.7 5815.5 4363.0 4375.4 4410.9 4480.0 4533.0 3872.4 3902.2 3944.1 3959.9 3968.7 5333.5 5365.5 5378.8 5383.4 5386.4 5646.7 5648.4 5681.4 5685.2 5689.8 5441.7 5469.0 5503.2 5513.5 5539.5 4991.2 4991.9 4997.7 5000.9 5053.0 5954.0 5985.5 5993.8 6009.5 6023.2 5798.9 5817.0 5836.4 5848.1 5907.5 5951.9 5957.9 5965.4 5985.3 6022.2 5350.2 5418.3 5676.2 5689.4 5724.0 5782.2 5827.7 5836.0 5861.4 5939.5 5636.0 5637.2 5639.7 5650.9 5669.4 5523.2 5651.6 5675.9 5689.3 5709.9 5524.9 5531.6 5586.4 5609.8 5615.7 5681.0 5733.6 5749.2 5758.6 5813.2 5571.9 5578.8 5615.7 5618.2 5621.6 20:45:18 INFO - PROCESS | 929 | 20:45:18 INFO - PROCESS | 929 | [#1] ext.html Cycles:180 Average:59256.09 Median:234333.79 stddev:115424.25 (49.3%) stddev-sans-first:115663.96 20:45:18 INFO - PROCESS | 929 | Values: 576.1 576.2 588.3 591.2 591.9 41932.4 43925.3 43969.1 47588.8 47685.0 44963.6 45345.3 45366.0 45480.0 45500.1 8726.3 8834.6 8871.7 8873.3 8900.9 8721.3 8724.7 8763.9 8767.4 8808.3 8755.6 8763.4 8796.7 8797.2 8831.4 8745.2 8745.4 8779.8 8790.8 8791.7 8550.0 8561.6 8593.4 8595.8 8599.3 42475.4 42967.0 43011.4 43093.4 43128.8 3608.8 3629.9 3807.9 4045.6 4186.4 31268.4 31458.4 31639.0 31684.8 32581.8 4252.8 4317.5 4349.1 4355.0 4442.4 346748.0 347094.0 347852.0 348182.0 348304.0 56959.0 57556.1 57624.4 57669.7 57689.7 59203.0 59348.7 59659.7 59690.4 59915.4 16164.6 16352.7 16484.9 16485.9 16519.2 12457.6 12460.0 12462.2 12488.3 12515.7 15208.8 16172.4 16380.2 16412.3 16542.0 5652.2 5828.8 5837.4 5866.9 5943.0 895.6 1026.3 1098.5 1125.2 1130.6 28680.7 29208.3 30172.5 30533.2 31308.8 1093.3 1105.5 1112.7 1130.2 1136.9 15864.8 15959.6 16190.5 16370.6 16535.8 509690.0 514356.0 516603.3 517872.0 518404.0 55548.7 56353.0 56570.0 56894.4 56922.4 1212.8 1268.3 1276.7 1283.1 1317.2 28788.3 29724.6 30628.1 30632.5 30955.7 49848.3 50062.2 50283.2 50318.0 50440.0 426057.0 426175.0 428939.0 430316.0 430480.0 39578.6 39687.6 39740.0 39922.0 39923.2 44737.0 45385.3 45451.3 46575.3 49839.5 39119.6 40250.6 40488.2 40760.8 41611.8 40560.2 41290.8 41321.0 41607.2 42610.6 38405.4 39337.4 39586.6 39704.4 42770.4 30753.8 34597.0 35932.6 36140.0 36395.3 26920.7 27075.5 27098.2 27110.3 27504.0 20:45:18 INFO - PROCESS | 929 | 20:45:18 INFO - PROCESS | 929 | [#2] jquery.html Cycles:180 Average:27512.07 Median:39363.40 stddev:74859.30 (190.2%) stddev-sans-first:75041.60 20:45:18 INFO - PROCESS | 929 | Values: 390.3 402.6 409.6 410.4 418.0 16051.7 16119.4 17621.1 19069.2 19297.6 12390.6 13085.7 13137.1 16044.8 19272.0 5266.4 5460.2 5490.7 5491.4 5497.5 5504.8 5765.8 5824.0 5891.2 5893.7 5663.6 5877.8 6013.1 6016.5 6032.5 5982.4 5987.5 6022.4 6022.7 6281.8 5823.4 5841.5 5850.6 5880.7 5891.6 15692.7 22235.0 22409.4 22632.5 22635.3 2319.8 2324.0 2357.3 2375.8 2392.6 9951.2 10136.1 10190.8 10823.2 10898.6 1867.5 1914.0 1971.1 1982.3 2012.8 73107.6 74923.6 75874.2 89696.6 89823.0 11005.3 11266.5 11343.3 11419.9 11685.8 16037.0 16070.4 16077.0 16158.3 16185.4 7238.4 7399.1 7437.9 7547.9 7553.4 6645.7 6707.6 6874.9 6904.1 6931.7 4677.2 4759.5 4804.0 4805.4 4948.4 1902.6 1947.7 1987.3 2013.2 2074.5 868.3 942.4 955.2 965.0 1007.4 18176.7 19247.7 19408.8 19433.8 19453.5 959.9 975.6 983.3 995.4 1027.1 10190.0 10750.0 10807.7 10841.9 10865.4 443990.0 449844.0 454473.0 456436.6 458500.0 89136.0 90058.5 90060.0 91330.0 92682.0 956.4 969.6 1005.9 1007.4 1016.6 15886.7 16225.5 16466.2 16864.4 17442.2 39178.8 39548.0 39657.2 40125.4 40152.6 52934.5 56784.7 57086.0 58453.4 58585.7 8486.0 8528.8 8576.5 8605.6 8767.8 11406.3 12829.6 12878.2 12893.8 13062.5 10540.2 11051.3 11632.7 11792.4 11808.0 10950.2 11103.8 11115.6 11260.0 11276.4 10708.6 10875.1 11610.1 11639.4 11644.8 8360.3 8400.8 8668.4 8670.5 8675.3 10235.6 10782.9 10871.7 10924.8 11474.6 20:45:18 INFO - PROCESS | 929 | 20:45:18 INFO - PROCESS | 929 | [#3] mootools.html Cycles:180 Average:5851.91 Median:463.77 stddev:3372.10 (727.1%) stddev-sans-first:3365.31 20:45:18 INFO - PROCESS | 929 | Values: 1446.8 1484.2 1627.5 1726.7 1734.6 7889.4 8159.1 8460.2 9051.4 9080.7 8452.4 8817.9 8818.3 9075.5 9095.7 2305.5 2314.9 2340.8 2343.2 2361.0 2320.8 2329.5 2401.0 2401.0 2402.6 2316.2 2320.4 2330.0 2395.3 2398.8 2297.5 2299.0 2309.2 2309.4 2357.1 2309.7 2316.7 2323.3 2323.5 2336.5 9069.5 9073.2 9133.0 9163.3 9195.5 5185.5 5247.3 5292.2 5382.3 5409.3 3343.1 3472.6 3511.9 3514.3 3563.0 1147.7 1177.7 1190.4 1192.7 1193.7 12405.2 12482.6 12529.9 12538.5 12596.3 4502.1 4587.4 4698.1 4740.1 4865.3 10466.8 10491.9 10507.8 10551.8 10568.8 5366.4 5366.9 5369.7 5371.8 5377.1 4356.3 4504.0 4810.0 4923.5 4980.8 3946.5 4054.5 4131.8 4154.2 4167.0 1278.4 1298.7 1301.8 1312.6 1328.6 964.8 965.6 991.4 996.8 1013.6 6009.6 6098.7 6100.6 6145.2 6161.4 460.6 467.0 470.4 479.6 481.6 4000.1 4082.7 4159.3 4219.6 4237.7 10977.7 11223.1 11323.9 11331.3 11337.7 11025.7 11213.6 11220.1 11231.8 11243.0 8226.9 8311.5 8324.8 8332.8 8347.2 5842.0 5863.0 5929.6 5973.2 6009.6 10030.3 10144.7 10152.8 10330.6 10346.0 10415.2 10575.2 10593.3 10602.3 10605.6 7145.5 7373.0 7920.2 7989.5 7993.6 8133.1 8382.3 8460.0 8605.8 8754.8 7620.8 7644.0 7699.9 7774.6 7992.4 7411.4 7446.9 7454.4 7668.5 7705.5 6877.2 6967.5 6984.3 6994.3 7008.4 4910.1 5005.8 5015.0 5120.9 5202.2 5009.5 5083.9 5164.6 5218.7 5238.9 20:45:18 INFO - PROCESS | 929 | 20:45:18 INFO - PROCESS | 929 | [#4] prototype.html Cycles:180 Average:4628.50 Median:5182.02 stddev:1334.50 (25.8%) stddev-sans-first:1298.52 20:45:18 INFO - PROCESS | 929 | Values: 322.5 331.9 332.5 334.1 345.6 5355.3 5456.2 5457.8 5540.2 5544.2 5183.5 5394.9 5435.5 5437.7 5460.4 4263.1 4266.9 4279.7 4284.7 4297.9 4131.0 4239.3 4254.6 4295.0 4300.2 4208.4 4220.8 4222.7 4237.6 4247.9 4209.6 4246.2 4264.0 4274.1 4299.3 3750.0 3825.3 3830.5 3838.4 3840.1 5300.6 5304.8 5346.3 5362.2 5391.2 4929.8 4941.6 4942.7 4943.7 4964.9 5432.6 5690.7 5696.0 5712.6 5776.7 4123.2 4127.4 4147.0 4149.3 4165.6 5952.8 5978.9 5979.7 5981.7 6005.3 3916.8 4120.3 4258.1 4281.7 4292.1 4162.4 4198.0 4206.1 4213.5 4236.9 4827.9 4828.3 4835.7 4842.9 4853.1 5566.7 5713.9 5765.9 5855.9 5867.8 1434.2 1448.5 1455.2 1458.4 1459.8 887.7 896.3 927.4 931.9 940.3 4826.8 4841.0 4856.6 4872.6 4903.3 5103.5 5167.9 5185.4 5202.2 5207.9 4761.0 4785.3 4851.8 4881.6 4885.4 2736.6 2753.9 2754.3 2765.9 2768.9 5325.3 5327.4 5329.5 5331.3 5342.3 5088.8 5205.3 5265.0 5293.7 5325.4 5314.8 5331.4 5354.8 5372.9 5378.3 5122.3 5139.3 5180.5 5204.7 5215.8 4764.3 4904.3 5108.6 5121.2 5135.7 5245.2 5378.8 5388.5 5403.9 5406.4 3846.0 3959.7 4036.3 4095.7 4149.8 5798.5 5829.3 5829.9 5836.0 5876.6 5601.0 5701.5 5728.2 5748.3 5774.1 5660.8 5672.4 5681.4 5699.4 5705.9 5578.5 5620.7 5634.9 5640.4 5657.4 5539.4 5641.5 5668.5 5712.9 5757.6 5563.8 5565.5 5586.7 5593.9 5628.3 20:45:18 INFO - PROCESS | 929 | 20:45:18 INFO - PROCESS | 929 | [#5] yui.html Cycles:180 Average:19852.13 Median:612.03 stddev:28612.56 (4675.0%) stddev-sans-first:28656.70 20:45:18 INFO - PROCESS | 929 | Values: 703.7 705.8 749.1 754.8 812.5 15819.8 16708.6 16715.1 16717.4 16725.0 15051.0 15201.0 15203.5 15283.8 15343.1 768.9 788.9 791.7 797.7 797.8 776.1 780.9 782.0 782.7 784.5 814.9 821.7 823.6 825.9 826.1 816.6 823.4 824.3 824.4 825.1 606.6 611.2 612.9 614.1 614.4 12284.6 12290.1 12298.5 12307.4 12318.3 12694.7 13172.9 13361.1 13388.5 13561.9 9678.8 9749.9 9943.3 9973.5 10407.6 3670.9 3713.5 3742.1 3782.5 4017.6 70322.6 70616.0 71197.6 71559.6 75255.0 9560.7 9748.5 9789.7 9921.5 9921.9 19492.3 19683.3 19758.7 19829.4 20192.8 7880.5 7992.9 7993.5 8087.7 8108.0 4390.0 4508.4 4631.1 4722.6 4732.5 3695.5 3782.8 3802.6 3808.4 3828.8 647.0 666.7 669.0 669.9 681.6 706.8 719.3 731.2 746.7 763.8 8842.1 9057.9 9216.0 9538.9 9645.7 595.3 674.2 718.4 720.2 738.0 4060.8 4363.3 4649.7 4737.9 4757.4 93856.0 95758.5 98004.0 123982.0 127934.0 85289.6 95700.0 95744.5 97363.0 97606.5 54785.0 81353.8 81912.2 85689.6 85726.6 9185.3 9453.3 9561.5 9650.2 9690.1 50530.7 50761.7 50998.5 51819.5 52390.7 69049.3 75378.0 77294.6 79872.6 80674.2 12018.4 12083.8 12198.1 12573.7 13644.9 13470.9 13711.5 14156.9 14172.5 14622.9 13242.9 13502.8 13525.5 13773.3 13909.2 13237.5 13425.2 13864.6 14346.1 14571.9 12237.2 12334.4 12452.9 13064.9 13273.7 10193.7 10618.4 10738.2 10754.5 11267.5 9786.2 10840.7 10846.9 10885.7 10899.8 20:45:18 INFO - PROCESS | 929 | -------- Summary: end -------- 20:45:18 INFO - PROCESS | 929 | 20:45:19 INFO - TEST-INFO | 929: exit 0 20:45:19 INFO - TEST-OK | dromaeo_css | took 1115213ms 20:45:19 INFO - TEST-START | kraken 20:45:19 INFO - operating with platform_type : linux_ 20:45:19 INFO - Initialising browser for kraken test... 20:45:19 INFO - TEST-INFO | started process 1379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMl41x0/profile http://localhost:39624/getInfo.html) 20:45:23 INFO - PROCESS | 1379 | __metrics Screen width/height:1600/1200 20:45:23 INFO - PROCESS | 1379 | colorDepth:24 20:45:23 INFO - PROCESS | 1379 | Browser inner width/height: 1024/697 20:45:23 INFO - PROCESS | 1379 | __metrics 20:45:24 ERROR - PROCESS | 1379 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 20:45:25 INFO - TEST-INFO | 1379: exit 0 20:45:25 INFO - Browser initialized. 20:45:25 INFO - Running cycle 1/1 for kraken test... 20:45:25 INFO - TEST-INFO | started process 1501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMl41x0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:45:37 INFO - PROCESS | 1501 | RSS: Main: 185180160 20:45:37 INFO - PROCESS | 1501 | 20:45:40 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39624/tests/kraken/driver.html?testName=audio-beat-detection) 20:45:41 INFO - PROCESS | 1501 | RSS: Main: 199163904 20:45:41 INFO - PROCESS | 1501 | 20:45:44 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39624/tests/kraken/driver.html?testName=audio-dft) 20:45:44 INFO - PROCESS | 1501 | RSS: Main: 196902912 20:45:44 INFO - PROCESS | 1501 | 20:45:47 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39624/tests/kraken/driver.html?testName=audio-fft) 20:45:48 INFO - PROCESS | 1501 | RSS: Main: 192045056 20:45:48 INFO - PROCESS | 1501 | 20:45:50 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39624/tests/kraken/driver.html?testName=audio-oscillator) 20:45:50 INFO - PROCESS | 1501 | RSS: Main: 192782336 20:45:50 INFO - PROCESS | 1501 | 20:45:53 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:45:53 INFO - PROCESS | 1501 | RSS: Main: 193339392 20:45:53 INFO - PROCESS | 1501 | 20:45:56 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39624/tests/kraken/driver.html?testName=imaging-darkroom) 20:45:57 INFO - PROCESS | 1501 | RSS: Main: 193933312 20:45:57 INFO - PROCESS | 1501 | 20:46:00 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39624/tests/kraken/driver.html?testName=imaging-desaturate) 20:46:01 INFO - PROCESS | 1501 | RSS: Main: 191803392 20:46:01 INFO - PROCESS | 1501 | 20:46:04 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39624/tests/kraken/driver.html?testName=json-parse-financial) 20:46:05 INFO - PROCESS | 1501 | RSS: Main: 192655360 20:46:05 INFO - PROCESS | 1501 | 20:46:06 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:46:07 INFO - PROCESS | 1501 | RSS: Main: 193015808 20:46:07 INFO - PROCESS | 1501 | 20:46:09 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39624/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:46:09 INFO - PROCESS | 1501 | RSS: Main: 192954368 20:46:09 INFO - PROCESS | 1501 | 20:46:11 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:46:12 INFO - PROCESS | 1501 | RSS: Main: 193302528 20:46:12 INFO - PROCESS | 1501 | 20:46:15 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:46:15 INFO - PROCESS | 1501 | RSS: Main: 193265664 20:46:15 INFO - PROCESS | 1501 | 20:46:18 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:46:19 INFO - PROCESS | 1501 | RSS: Main: 193519616 20:46:19 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | Cycle 1(1): loaded http://localhost:39624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39624/tests/kraken/driver.html?testName=ai-astar) 20:46:21 INFO - PROCESS | 1501 | RSS: Main: 194867200 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | __start_tp_report 20:46:21 INFO - PROCESS | 1501 | _x_x_mozilla_page_load 20:46:21 INFO - PROCESS | 1501 | _x_x_mozilla_page_load_details 20:46:21 INFO - PROCESS | 1501 | |i|pagename|runs| 20:46:21 INFO - PROCESS | 1501 | |0;ai-astar;109;111;112;112;114;113;112;112;113;112 20:46:21 INFO - PROCESS | 1501 | |1;audio-beat-detection;149;124;125;170;130;125;128;126;159;130 20:46:21 INFO - PROCESS | 1501 | |2;audio-dft;164;167;165;174;163;163;163;164;162;162 20:46:21 INFO - PROCESS | 1501 | |3;audio-fft;76;75;76;115;77;75;76;76;103;75 20:46:21 INFO - PROCESS | 1501 | |4;audio-oscillator;83;81;114;84;82;81;105;82;83;122 20:46:21 INFO - PROCESS | 1501 | |5;imaging-gaussian-blur;119;118;117;118;119;117;118;117;117;117 20:46:21 INFO - PROCESS | 1501 | |6;imaging-darkroom;148;147;147;147;148;146;146;146;148;147 20:46:21 INFO - PROCESS | 1501 | |7;imaging-desaturate;98;103;96;96;95;96;95;96;96;96 20:46:21 INFO - PROCESS | 1501 | |8;json-parse-financial;54;57;52;51;54;54;53;54;55;52 20:46:21 INFO - PROCESS | 1501 | |9;json-stringify-tinderbox;63;62;62;62;64;63;61;62;63;62 20:46:21 INFO - PROCESS | 1501 | |10;stanford-crypto-aes;82;81;81;82;82;80;80;87;81;79 20:46:21 INFO - PROCESS | 1501 | |11;stanford-crypto-ccm;141;151;141;134;143;152;136;131;183;131 20:46:21 INFO - PROCESS | 1501 | |12;stanford-crypto-pbkdf2;170;167;164;170;175;166;167;169;167;168 20:46:21 INFO - PROCESS | 1501 | |13;stanford-crypto-sha256-iterative;67;66;69;67;68;69;65;66;66;70 20:46:21 INFO - PROCESS | 1501 | __end_tp_report 20:46:21 INFO - PROCESS | 1501 | __start_cc_report 20:46:21 INFO - PROCESS | 1501 | _x_x_mozilla_cycle_collect,779 20:46:21 INFO - PROCESS | 1501 | __end_cc_report 20:46:21 INFO - PROCESS | 1501 | __startTimestamp1475811981277__endTimestamp 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | ------- Summary: start ------- 20:46:21 INFO - PROCESS | 1501 | Number of tests: 14 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:1.33 (1.2%) stddev-sans-first:0.87 20:46:21 INFO - PROCESS | 1501 | Values: 109.0 111.0 112.0 112.0 114.0 113.0 112.0 112.0 113.0 112.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:130.00 stddev:16.57 (12.7%) stddev-sans-first:16.96 20:46:21 INFO - PROCESS | 1501 | Values: 149.0 124.0 125.0 170.0 130.0 125.0 128.0 126.0 159.0 130.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.59 (2.2%) stddev-sans-first:3.80 20:46:21 INFO - PROCESS | 1501 | Values: 164.0 167.0 165.0 174.0 163.0 163.0 163.0 164.0 162.0 162.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:14.32 (18.8%) stddev-sans-first:15.00 20:46:21 INFO - PROCESS | 1501 | Values: 76.0 75.0 76.0 115.0 77.0 75.0 76.0 76.0 103.0 75.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:82.00 stddev:15.71 (19.2%) stddev-sans-first:16.34 20:46:21 INFO - PROCESS | 1501 | Values: 83.0 81.0 114.0 84.0 82.0 81.0 105.0 82.0 83.0 122.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 20:46:21 INFO - PROCESS | 1501 | Values: 119.0 118.0 117.0 118.0 119.0 117.0 118.0 117.0 117.0 117.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 20:46:21 INFO - PROCESS | 1501 | Values: 148.0 147.0 147.0 147.0 148.0 146.0 146.0 146.0 148.0 147.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:2.36 (2.5%) stddev-sans-first:2.46 20:46:21 INFO - PROCESS | 1501 | Values: 98.0 103.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.71 (3.2%) stddev-sans-first:1.81 20:46:21 INFO - PROCESS | 1501 | Values: 54.0 57.0 52.0 51.0 54.0 54.0 53.0 54.0 55.0 52.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 20:46:21 INFO - PROCESS | 1501 | Values: 63.0 62.0 62.0 62.0 64.0 63.0 61.0 62.0 63.0 62.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:2.17 (2.7%) stddev-sans-first:2.30 20:46:21 INFO - PROCESS | 1501 | Values: 82.0 81.0 81.0 82.0 82.0 80.0 80.0 87.0 81.0 79.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:142.00 stddev:15.47 (10.9%) stddev-sans-first:16.36 20:46:21 INFO - PROCESS | 1501 | Values: 141.0 151.0 141.0 134.0 143.0 152.0 136.0 131.0 183.0 131.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.50 stddev:2.98 (1.8%) stddev-sans-first:3.10 20:46:21 INFO - PROCESS | 1501 | Values: 170.0 167.0 164.0 170.0 175.0 166.0 167.0 169.0 167.0 168.0 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.64 (2.4%) stddev-sans-first:1.73 20:46:21 INFO - PROCESS | 1501 | Values: 67.0 66.0 69.0 67.0 68.0 69.0 65.0 66.0 66.0 70.0 20:46:21 INFO - PROCESS | 1501 | -------- Summary: end -------- 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | 20:46:21 INFO - PROCESS | 1501 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 20:46:21 INFO - PROCESS | 1501 | 20:46:22 INFO - TEST-INFO | 1501: exit 0 20:46:22 INFO - TEST-OK | kraken | took 63068ms 20:46:22 INFO - SUITE-END | took 1178s 20:46:22 INFO - Completed test suite (00:19:38) 20:46:22 INFO - javascript benchmark 20:46:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7148.885084243618, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.8015678980864, 3071.9539206911886, 3089.2894634234126, 3090.2737856603694, 3106.953395699065, 5250.737463126848, 5292.073887069761, 5364.490373414519, 5379.9731001344935, 5395.325584301962, 5315.760790764415, 5340.893182136355, 5395.0558652235795, 5433.891322173554, 5487.670739755617, 4817.205161148407, 4935.901281974358, 4945.752712364368, 4947.18371468709, 4972.825951091712, 4862.17343051682, 4902.264660300948, 4906.215005599105, 4924.0, 4976.925346119811, 4701.764911754399, 4703.318018887242, 4755.690880092783, 4832.855014349575, 4872.439669438007, 4782.641301902337, 4833.879153021167, 4854.587360074398, 4903.043906438246, 4908.901821963576, 4765.428148622187, 4804.615630749532, 4815.855524334275, 4831.4685384607665, 4878.243872199815, 5151.742412879341, 5179.974100129513, 5281.128613778722, 5303.5226829585135, 5388.461153884619, 5640.266765320482, 5649.548036157139, 5724.484796368347, 5770.88458230833, 5776.075827867563, 5640.605157638967, 5665.093585026417, 5672.914906276409, 5678.063119585305, 5727.11229759388, 5340.626156169031, 5360.249565060894, 5371.704556249405, 5381.569474442035, 5431.701256430855, 5887.676177810262, 5952.136940143741, 5962.701864906824, 5973.910391344133, 6037.396260373927, 5676.971615141898, 5736.168255602997, 5737.741801618937, 5743.8564035899435, 5744.798932037359, 5635.239242702182, 5743.396943320891, 5794.82615521535, 5828.388019258002, 5830.4461076197695, 5793.333766616809, 5796.246487956623, 5801.448862358069, 5805.970970145122, 5865.618734782225, 5796.681182535001, 5800.361960184377, 5806.796762113306, 5813.7383817728305, 5815.534757219412, 4363.0, 4375.409319741858, 4410.889727756768, 4479.955200448019, 4533.0, 3872.3997780344093, 3902.161035377351, 3944.1322908959983, 3959.920801583952, 3968.7420317679257, 5333.466653334635, 5365.490278423544, 5378.757955891916, 5383.380911195184, 5386.434424385461, 5646.745896434671, 5648.435156484319, 5681.375048744718, 5685.1756495307945, 5689.800856970069, 5441.673499590037, 5469.0, 5503.229547863302, 5513.531349835309, 5539.529140023144, 4991.226359914219, 4991.925121123186, 4997.675151115166, 5000.924986125211, 5053.0, 5954.0, 5985.521158307412, 5993.760249590055, 6009.549283803733, 6023.216981792339, 5798.913016304675, 5817.040188368872, 5836.445537673914, 5848.093545500455, 5907.4683278505145, 5951.910721339097, 5957.91063134062, 5965.403459654173, 5985.281766188085, 6022.1870047543025, 5350.2242174885205, 5418.295621569171, 5676.2337084493065, 5689.402612725604, 5723.971380143073, 5782.248307720138, 5827.679477628772, 5836.0, 5861.35525092248, 5939.465448109518, 5635.971820140873, 5637.182608521824, 5639.689817060101, 5650.85872853182, 5669.4047125051275, 5523.171524271392, 5651.604387692986, 5675.858103547279, 5689.260396148474, 5709.857253568694, 5524.889502209853, 5531.585131115102, 5586.38549759518, 5609.775608975759, 5615.6630602164005, 5681.0, 5733.627314224562, 5749.195112684144, 5758.596898217253, 5813.186153938367, 5571.916421253765, 5578.776848925998, 5615.691136987505, 5618.157276408408, 5621.634593751393], "value": 5307.188684456503, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.0782747603835, 576.1789450033701, 588.3293045927641, 591.2018774654217, 591.9079298693911, 41932.37101443477, 43925.34111988319, 43969.12061758763, 47588.76205618967, 47685.0, 44963.55036449643, 45345.31982020264, 45366.0, 45480.0, 45500.08999820002, 8726.301895848334, 8834.602442890053, 8871.733847984571, 8873.29013678904, 8900.866487002668, 8721.345899057564, 8724.651013959434, 8763.912360876373, 8767.386282960164, 8808.339374546935, 8755.605997730117, 8763.430377025505, 8796.736097917073, 8797.164269394429, 8831.425957312786, 8745.212930836224, 8745.431546949429, 8779.78050548735, 8790.824183516293, 8791.692290769824, 8549.957250213709, 8561.614727337284, 8593.355498337649, 8595.796588477619, 8599.269062129726, 42475.36286955698, 42967.0, 43011.35482967758, 43093.35359969603, 43128.78435607802, 3608.8015159166234, 3629.8548058077645, 3807.8857634271017, 4045.554988951213, 4186.413902053715, 31268.37463250745, 31458.37083258345, 31639.0, 31684.841575791972, 32581.83709081463, 4252.766097864616, 4317.460317460317, 4349.086691794727, 4355.041890784022, 4442.444694413199, 346748.0, 347094.0, 347852.0, 348182.0, 348304.0, 56959.0, 57556.13665795016, 57624.423755761905, 57669.711651441474, 57689.711551442815, 59203.0, 59348.703256483444, 59659.70170149121, 59690.403095969355, 59915.400845991855, 16164.595885102966, 16352.672946541003, 16484.917575412048, 16485.91757041207, 16519.174041297887, 12457.563985260473, 12460.0, 12462.189957652723, 12488.313142777235, 12515.74968500643, 15208.847911520965, 16172.353105875869, 16380.180990950405, 16412.261448234618, 16542.0, 5652.236948011966, 5828.79599214034, 5837.357890632027, 5866.853328666817, 5943.0, 895.6193617712446, 1026.2867307221409, 1098.5386137822134, 1125.1954852280658, 1130.6268931252666, 28680.71319286822, 29208.26979325534, 30172.491375431142, 30533.236669083006, 31308.843455782575, 1093.2893619147617, 1105.5190991918541, 1112.6606385052476, 1130.1975597325827, 1136.9033632141195, 15864.762028569581, 15959.601009974844, 16190.514284571482, 16370.590735231715, 16535.751963720555, 509690.0, 514356.0, 516603.2547558948, 517872.0, 518404.0, 55548.72225638846, 56353.0, 56570.0, 56894.43105568974, 56922.43077569254, 1212.7998880184848, 1268.321448025302, 1276.7446510698082, 1283.1402960016624, 1317.2096741954751, 28788.280292992844, 29724.554131687608, 30628.08115756531, 30632.540511892785, 30955.69044309528, 49848.252276215164, 50062.249066263306, 50283.24575131303, 50318.0, 50440.0, 426057.0, 426175.0, 428939.0, 430316.0, 430480.0, 39578.60421395749, 39687.60312396839, 39740.03249593801, 39922.0, 39923.201535969696, 44737.0, 45385.319220211066, 45451.31823022591, 46575.30137048015, 49839.50160498349, 39119.60880391159, 40250.59749402468, 40488.1902361957, 40760.79619601883, 41611.7919410401, 40560.18879622332, 41290.79354603208, 41321.0, 41607.16785664209, 42610.57389426066, 38405.423918640685, 39337.40993885151, 39586.604133958295, 39704.404433932934, 42770.35844462273, 30753.846230768704, 34597.0, 35932.64067359293, 36140.0, 36395.27209455743, 26920.730792691822, 27075.458490830468, 27098.1870543884, 27110.32224194332, 27504.0], "value": 19838.328006882406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.3364280722772, 402.63963752441583, 409.63951722484217, 410.3741793764508, 418.03851142372554, 16051.678966420664, 16119.355225790983, 17621.11894405281, 19069.237230510782, 19297.61404771904, 12390.566330178446, 13085.738285234289, 13137.080404371674, 16044.83955160448, 19272.0, 5266.3943646480575, 5460.235567020621, 5490.670559766407, 5491.423400542945, 5497.532709719659, 5504.80733174339, 5765.769369225247, 5824.0390335594575, 5891.234139561851, 5893.7347819348015, 5663.603547751659, 5877.794277200299, 6013.067974463965, 6016.518678505709, 6032.457078862902, 5982.401759824026, 5987.520998320124, 6022.397760223965, 6022.698865056752, 6281.780137695205, 5823.388544202882, 5841.503472204868, 5850.64896106235, 5880.70596470179, 5891.558133140032, 15692.68614627701, 22235.0, 22409.439764005867, 22632.547349053093, 22635.320940371814, 2319.756425575324, 2323.9535209295886, 2357.316378250305, 2375.8099352051795, 2392.605220138675, 9951.154151897097, 10136.074145912327, 10190.796184076276, 10823.188260880466, 10898.618548350769, 1867.4864412286595, 1914.0238478375989, 1971.0637447212603, 1982.266561372287, 2012.8289095426906, 73107.63446182788, 74923.62538187274, 75874.24125758727, 89696.55151724265, 89823.0, 11005.284656497302, 11266.493007814668, 11343.319400835977, 11419.942900285445, 11685.76628467443, 16037.0, 16070.43753468623, 16077.0, 16158.27287772053, 16185.352585896668, 7238.384737297283, 7399.149097853816, 7437.888431673529, 7547.886781698279, 7553.433492488085, 6645.700943457459, 6707.564008339442, 6874.862502749917, 6904.067950826675, 6931.707438966551, 4677.18149323867, 4759.4764575896625, 4803.975980120077, 4805.423349198119, 4948.4309304429735, 1902.6194761047846, 1947.7078438234378, 1987.2547794577033, 2013.1947221111673, 2074.512489564951, 868.2793281576277, 942.4204114469552, 955.1594596754811, 964.9662261820943, 1007.4106647611083, 18176.727349089775, 19247.711284330748, 19408.80591194098, 19433.805661943483, 19453.47104876357, 959.9088086631759, 975.6292608808608, 983.3165949665057, 995.4077323992213, 1027.1474676018886, 10190.0, 10750.0, 10807.729806754895, 10841.891581084246, 10865.40240286776, 443990.0, 449844.0, 454473.0, 456436.5890852689, 458500.0, 89136.0, 90058.54970725236, 90060.0, 91330.0, 92682.0, 956.4261443134203, 969.6024629901707, 1005.8583507718791, 1007.3955626624113, 1016.6035246253966, 15886.68226635484, 16225.51323460298, 16466.176691165634, 16864.409745658842, 17442.21510032077, 39178.80410597929, 39548.0, 39657.20685586215, 40125.398119028825, 40152.59847401606, 52934.47065529296, 56784.716076419354, 57086.0, 58453.415465844795, 58585.70707146607, 8485.95757021211, 8528.829423411373, 8576.485410875368, 8605.569721514024, 8767.780805479659, 11406.315621062762, 12829.61511154667, 12878.227306361649, 12893.806592901301, 13062.54281100157, 10540.209484288556, 11051.281666691639, 11632.651020469399, 11792.351420671945, 11808.0, 10950.233483656068, 11103.833442498208, 11115.610953616584, 11260.0, 11276.436178191221, 10708.62519811834, 10875.129989600971, 11610.129240306842, 11639.43932334885, 11644.767104658029, 8360.331173505983, 8400.789980250544, 8668.393212475066, 8670.523121228392, 8675.262602678842, 10235.590576376862, 10782.946085269523, 10871.67384978452, 10924.836127458253, 11474.598389056342], "value": 8984.486853049826, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.8263808343002, 1484.1985327922923, 1627.454802641115, 1726.6891959447294, 1734.6443978984316, 7889.408294377916, 8159.061707903593, 8460.153984601544, 9051.411658242218, 9080.727578172657, 8452.366072544553, 8817.867731984026, 8818.338624603164, 9075.500847453388, 9095.681651142211, 2305.4927915858484, 2314.872682002489, 2340.8361414700976, 2343.16817529777, 2361.0437772702, 2320.7679232076744, 2329.4642232286583, 2400.987995060022, 2401.0395841663385, 2402.615581506959, 2316.247219653611, 2320.3503019154577, 2330.0, 2395.3053614451787, 2398.8080953523763, 2297.5060362022245, 2298.9885050574726, 2309.2379514760087, 2309.3764683535437, 2357.116081469449, 2309.6881920940796, 2316.7104111986, 2323.256557901472, 2323.4772176260376, 2336.5210131923086, 9069.501177435239, 9073.228775554086, 9132.99537050924, 9163.266938644892, 9195.540222988891, 5185.455527169668, 5247.344081989751, 5292.153255479105, 5382.273393091921, 5409.323834520685, 3343.147497388175, 3472.58329000519, 3511.9122021949656, 3514.2795726876184, 3563.0379797454543, 1147.7245461089362, 1177.6937996120985, 1190.4107466803987, 1192.7375977284983, 1193.7194759231575, 12405.193662411913, 12482.563110291187, 12529.872311491918, 12538.498460061586, 12596.307203103826, 4502.099580083996, 4587.4036375271, 4698.073857150463, 4740.1230772307235, 4865.343178670834, 10466.790664186674, 10491.895081049244, 10507.842382364272, 10551.788964220672, 10568.788624227625, 5366.409694933554, 5366.892662146735, 5369.704666243316, 5371.838844834661, 5377.139657654757, 4356.259435895905, 4504.0, 4810.0, 4923.458419573844, 4980.7509624518625, 3946.506686664167, 4054.493188351456, 4131.814068366931, 4154.189932963043, 4166.958330416657, 1278.4310981613094, 1298.7077907470743, 1301.7982212757038, 1312.5799744081803, 1328.5682153300022, 964.768455570672, 965.5944503308627, 991.375433476905, 996.8205722969935, 1013.5894962540183, 6009.579329446897, 6098.69506524672, 6100.633961962297, 6145.201123853871, 6161.44546990773, 460.55386087684695, 466.9813207471663, 470.407286818611, 479.59474244263544, 481.6195205787459, 4000.139969906484, 4082.7142100053306, 4159.313713237342, 4219.578042195817, 4237.703360764717, 10977.725556861142, 11223.102151827834, 11323.886761132284, 11331.32012079278, 11337.659870203906, 11025.669229923114, 11213.551457941754, 11220.102391808636, 11231.775364492827, 11243.0, 8226.876596851052, 8311.459755116019, 8324.833503329899, 8332.833343333221, 8347.248747612623, 5842.006858834094, 5863.0, 5929.6145750526075, 5973.193618861398, 6009.639421634716, 10030.348027378197, 10144.695659130239, 10152.847707284544, 10330.638427654996, 10346.017128372792, 10415.218858585486, 10575.206859485415, 10593.2584719072, 10602.25784195099, 10605.575776969143, 7145.4998150128995, 7372.96313518429, 7920.207979202034, 7989.480683755537, 7993.640286187252, 8133.0646975598565, 8382.287505562095, 8459.957700211706, 8605.784855378666, 8754.824903501767, 7620.8475830484185, 7644.0, 7699.923000769921, 7774.572398518136, 7992.440529163136, 7411.444141689502, 7446.8510629786015, 7454.366378857858, 7668.501547399401, 7705.460617756703, 6877.1747390313485, 6967.512274140761, 6984.26665200167, 6994.300569942965, 7008.439324854102, 4910.06708725341, 5005.799768009385, 5014.974925125351, 5120.948790512047, 5202.193659982709, 5009.474005229398, 5083.898322033612, 5164.561012313995, 5218.739063046756, 5238.947610523846], "value": 4605.862161894455, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.5307178055929, 331.87720543398945, 332.51452878796954, 334.05629097798715, 345.63017571198793, 5355.3305836770405, 5456.208849716789, 5457.781688732456, 5540.196671482638, 5544.223808666785, 5183.496785932075, 5394.8921021579545, 5435.456454354563, 5437.673739575628, 5460.399356070839, 4263.126059157865, 4266.863855066524, 4279.72181808183, 4284.721493102954, 4297.892552686177, 4131.0, 4239.258129827268, 4254.595813397722, 4295.0, 4300.22595932732, 4208.389783481393, 4220.831166753326, 4222.683298752606, 4237.555056719047, 4247.895547157746, 4209.6000879916355, 4246.171996460692, 4263.957360426402, 4274.123804620045, 4299.269124248885, 3749.9625003749884, 3825.3114439400897, 3830.5020347354944, 3838.366669499529, 3840.135969406861, 5300.575953923715, 5304.761285742151, 5346.304980352568, 5362.195670649395, 5391.245225668409, 4929.75351232437, 4941.629377796644, 4942.654014219006, 4943.6539442239055, 4964.90070198594, 5432.641839540115, 5690.715464226772, 5695.974724549579, 5712.6286791358425, 5776.740046697867, 4123.154753275601, 4127.40152677863, 4146.958530414688, 4149.33610622299, 4165.562615925345, 5952.821415357546, 5978.8505287367725, 5979.730912108966, 5981.700914954235, 6005.339412664647, 3916.784576848244, 4120.320147175682, 4258.127083947783, 4281.657467402601, 4292.120115376403, 4162.354835000579, 4197.97901010493, 4206.11671548972, 4213.494380674339, 4236.872893813191, 4827.8551643450755, 4828.299896514985, 4835.685680430761, 4842.927356089662, 4853.12643724126, 5566.749496272678, 5713.942860571424, 5765.942340576625, 5855.853603659857, 5867.765289388462, 1434.2255182201702, 1448.5364683301243, 1455.163281113364, 1458.4385011770544, 1459.7883756482095, 887.7159309021051, 896.2695403246464, 927.4157280913116, 931.8881734191805, 940.3276657190141, 4826.817429729668, 4841.0, 4856.635752318591, 4872.585830204402, 4903.289023091632, 5103.464136265713, 5167.896642067138, 5185.351831021122, 5202.167653175549, 5207.92188117171, 4761.0, 4785.320220676433, 4851.757412129379, 4881.609471242292, 4885.389326334208, 2736.6305548750665, 2753.9449211015667, 2754.311422144464, 2765.9446811064067, 2768.9307767305977, 5325.254464374991, 5327.413984461706, 5329.546988505943, 5331.306930099062, 5342.305500284938, 5088.821891233789, 5205.323307969939, 5264.973675131677, 5293.682379057269, 5325.360956685223, 5314.7874085036165, 5331.413544510101, 5354.8487075279, 5372.892542149135, 5378.300820893259, 5122.334096567572, 5139.331886854685, 5180.5494461550825, 5204.687718736888, 5215.843524694265, 4764.331974094518, 4904.313396124474, 5108.59131269505, 5121.180611102206, 5135.717535535432, 5245.246245721027, 5378.838634840961, 5388.464287677993, 5403.9459605403445, 5406.350888064899, 3845.9615403845605, 3959.7030222732833, 4036.313826649418, 4095.6928230383437, 4149.792510374409, 5798.478136967693, 5829.300483941955, 5829.883402332014, 5836.0, 5876.647401155944, 5601.011640867433, 5701.543876489788, 5728.2266893970445, 5748.310202775694, 5774.105013722712, 5660.782931669711, 5672.440078978314, 5681.375048744552, 5699.401562835843, 5705.942940570541, 5578.49793518569, 5620.747066382104, 5634.943650563442, 5640.379558248672, 5657.377688454185, 5539.418361072029, 5641.464060914206, 5668.461496157858, 5712.943340397536, 5757.596968212185, 5563.833085007456, 5565.526930210977, 5586.664800112007, 5593.944060559343, 5628.324601047901], "value": 4201.994598758584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.7009271059799, 705.8059033765713, 749.1160430691789, 754.8414832885094, 812.4678335690123, 15819.762703559441, 16708.582285442855, 16715.080670563115, 16717.414890478834, 16725.0, 15051.0, 15201.0, 15203.54389368318, 15283.770743438858, 15343.079415235094, 768.8577613141558, 788.8737801951689, 791.6556298010383, 797.7048492057946, 797.8444203380343, 776.130733578393, 780.910195327536, 781.9765407037798, 782.659543098751, 784.4548039112819, 814.8940637717088, 821.7411515372669, 823.6005537314397, 825.9256666899978, 826.1490664615455, 816.5917041479261, 823.4400607586839, 824.3240542754943, 824.4352618456377, 825.0635528674967, 606.6087373644019, 611.1749138662814, 612.8866159760458, 614.0727501472763, 614.3610644929269, 12284.631461056093, 12290.078244131637, 12298.508059677602, 12307.384630768425, 12318.260904345769, 12694.746105077938, 13172.934135329358, 13361.077428980612, 13388.456193323238, 13561.86438135616, 9678.806423871483, 9749.902500974971, 9943.254255930762, 9973.501324933724, 10407.583696652126, 3670.944935825965, 3713.4801127842125, 3742.101895545077, 3782.451544526028, 4017.5982401759884, 70322.64838675826, 70616.0, 71197.64401177962, 71559.64220178917, 75255.0, 9560.749245675644, 9748.46383448903, 9789.657361992297, 9921.454320012324, 9921.851172232422, 19492.31776887802, 19683.311084112273, 19758.70361944572, 19829.4051178462, 20192.798072019094, 7880.527168369917, 7992.920070799334, 7993.521198578282, 8087.676492940334, 8107.959460202661, 4389.956100439019, 4508.391367165456, 4631.096936097429, 4722.645801564828, 4732.479427262998, 3695.4826324314618, 3782.7541209821275, 3802.6387493188104, 3808.352580061396, 3828.789416582115, 646.9708863101172, 666.7299743603849, 669.0399277037467, 669.88611935971, 681.5876394781185, 706.8056284521798, 719.3274288540232, 731.1920328037442, 746.7423738810102, 763.8357753083113, 8842.115788421235, 9057.909420905838, 9216.0, 9538.904610953941, 9645.662401815904, 595.2886300870505, 674.2414783368711, 718.4396170986639, 720.2365492577884, 738.0368618952211, 4060.837566497307, 4363.2582460981075, 4649.721016739007, 4737.857864264078, 4757.429108507002, 93856.0, 95758.52120739351, 98004.0, 123982.0, 127934.0, 85289.57355213308, 95700.0, 95744.52127739455, 97363.0, 97606.51196744113, 54785.0, 81353.77969330465, 81912.18087819165, 85689.57155214308, 85726.57136714277, 9185.265178785547, 9453.291003174652, 9561.474118923526, 9650.179734722627, 9690.12788849007, 50530.74734626304, 50761.74619126881, 50998.490015100855, 51819.481805181465, 52390.738046309525, 69049.30950690429, 75378.0, 77294.61352693201, 79872.60063699645, 80674.19325806666, 12018.399080046138, 12083.758324833278, 12198.085143614442, 12573.748525029265, 13644.863551364757, 13470.865291346961, 13711.546144626687, 14156.858431415554, 14172.50396236168, 14622.926885365505, 13242.867571324163, 13502.797458038334, 13525.458981640624, 13773.311334433038, 13909.165450073027, 13237.536686215935, 13425.194488330731, 13864.584062478141, 14346.139231646135, 14571.854281457474, 12237.204581702517, 12334.444949977093, 12452.937735311265, 13064.869351306745, 13273.734525309246, 10193.74515637115, 10618.415987120474, 10738.248322617343, 10754.462276885968, 11267.492962816857, 9786.217102631916, 10840.728981775203, 10846.891531084904, 10885.727856803644, 10899.836502452628], "value": 7290.475105270496, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 112.0, 114.0, 113.0, 112.0, 112.0, 113.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 125.0, 170.0, 130.0, 125.0, 128.0, 126.0, 159.0, 130.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 165.0, 174.0, 163.0, 163.0, 163.0, 164.0, 162.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 115.0, 77.0, 75.0, 76.0, 76.0, 103.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 114.0, 84.0, 82.0, 81.0, 105.0, 82.0, 83.0, 122.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 119.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 146.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 103.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 52.0, 51.0, 54.0, 54.0, 53.0, 54.0, 55.0, 52.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 64.0, 63.0, 61.0, 62.0, 63.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 82.0, 82.0, 80.0, 80.0, 87.0, 81.0, 79.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 151.0, 141.0, 134.0, 143.0, 152.0, 136.0, 131.0, 183.0, 131.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 164.0, 170.0, 175.0, 166.0, 167.0, 169.0, 167.0, 168.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 67.0, 68.0, 69.0, 65.0, 66.0, 66.0, 70.0], "value": 67.3, "unit": "score"}]}]} 20:46:22 INFO - Return code: 0 20:46:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:46:22 ERROR - # TBPL SUCCESS # 20:46:22 INFO - Running post-action listener: _resource_record_post_action 20:46:22 INFO - [mozharness: 2016-10-07 03:46:22.573105Z] Finished run-tests step (success) 20:46:22 INFO - Running post-run listener: _resource_record_post_run 20:46:22 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 404025344; Read time: 0; Write time: 282220 20:46:22 INFO - TinderboxPrint: CPU usage
13.5% 20:46:22 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:46:22 INFO - TinderboxPrint: I/O write bytes / time
404,025,344 / 282,220 20:46:22 INFO - TinderboxPrint: CPU idle
8,244.7 (86.5%) 20:46:22 INFO - TinderboxPrint: CPU user
1,223.6 (12.8%) 20:46:22 INFO - TinderboxPrint: Swap in / out
0 / 0 20:46:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115224576; Read time: 0; Write time: 58560 20:46:22 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288800768; Read time: 0; Write time: 223660 20:46:23 INFO - Running post-run listener: _upload_blobber_files 20:46:23 INFO - Blob upload gear active. 20:46:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:46:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:46:23 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:46:23 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:46:23 INFO - (blobuploader) - INFO - Open directory for files ... 20:46:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:46:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:46:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:46:24 INFO - (blobuploader) - INFO - Done attempting. 20:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:46:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:46:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:46:27 INFO - (blobuploader) - INFO - Done attempting. 20:46:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:46:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:46:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:46:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:46:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:46:28 INFO - (blobuploader) - INFO - Done attempting. 20:46:28 INFO - (blobuploader) - INFO - Iteration through files over. 20:46:28 INFO - Return code: 0 20:46:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:46:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:46:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/266d5e68df7f29511ee24e57df6d2cfa57a8f276fe00df7b06c29cf618de2084169f0ae468000fff8b2e6d260249544f69c84b1de30798a929e1ed7a02e19ded", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2c0b6fb29f42d0cb7d348500485e44bf653b40e6a9ee8827f2fdda02d3de759892c671e99818c5a63275c61398fe0755c19e9c9437193e6be8dc829eb75d8301", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/88eb415651bbbae273a283c4988f8270803f9057a950b75dd4c1ea9581a10a0737f957de8272a3a44c3fb39c42c8a08bb401db111bfcedc7269b4756d3e578d2"} 20:46:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:46:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:46:28 INFO - Contents: 20:46:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/266d5e68df7f29511ee24e57df6d2cfa57a8f276fe00df7b06c29cf618de2084169f0ae468000fff8b2e6d260249544f69c84b1de30798a929e1ed7a02e19ded", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2c0b6fb29f42d0cb7d348500485e44bf653b40e6a9ee8827f2fdda02d3de759892c671e99818c5a63275c61398fe0755c19e9c9437193e6be8dc829eb75d8301", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/88eb415651bbbae273a283c4988f8270803f9057a950b75dd4c1ea9581a10a0737f957de8272a3a44c3fb39c42c8a08bb401db111bfcedc7269b4756d3e578d2"} 20:46:28 INFO - Running post-run listener: copy_logs_to_upload_dir 20:46:28 INFO - Copying logs to upload dir... 20:46:28 INFO - mkdir: /builds/slave/test/build/upload/logs 20:46:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.919662 ========= master_lag: 0.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-06 20:46:29.172619) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 20:46:29.179226) ========= 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=db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/266d5e68df7f29511ee24e57df6d2cfa57a8f276fe00df7b06c29cf618de2084169f0ae468000fff8b2e6d260249544f69c84b1de30798a929e1ed7a02e19ded", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2c0b6fb29f42d0cb7d348500485e44bf653b40e6a9ee8827f2fdda02d3de759892c671e99818c5a63275c61398fe0755c19e9c9437193e6be8dc829eb75d8301", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/88eb415651bbbae273a283c4988f8270803f9057a950b75dd4c1ea9581a10a0737f957de8272a3a44c3fb39c42c8a08bb401db111bfcedc7269b4756d3e578d2"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475803801/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/266d5e68df7f29511ee24e57df6d2cfa57a8f276fe00df7b06c29cf618de2084169f0ae468000fff8b2e6d260249544f69c84b1de30798a929e1ed7a02e19ded", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2c0b6fb29f42d0cb7d348500485e44bf653b40e6a9ee8827f2fdda02d3de759892c671e99818c5a63275c61398fe0755c19e9c9437193e6be8dc829eb75d8301", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/88eb415651bbbae273a283c4988f8270803f9057a950b75dd4c1ea9581a10a0737f957de8272a3a44c3fb39c42c8a08bb401db111bfcedc7269b4756d3e578d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 20:46:29.212084) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 20:46:29.212460) ========= 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=db0483c52d987ecb441a263b000001ad-1475810745.724278-414742935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 20:46:29.266230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 20:46:29.266709) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 20:46:29.267139) ========= ========= Total master_lag: 0.93 =========