builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1477963005.57 results: success (0) buildid: 20161031112308 builduid: 04404669c0d3437297eb5bc6c1d28a94 revision: e3279760cd977aac30bd9e8032d3ee71f55d2a67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:45.568262) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:45.568702) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:45.568968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:45.583669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:45.583936) ========= 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=8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 18:16:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.2M=0s 2016-10-31 18:16:45 (50.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:45.689688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:45.689986) ========= 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=8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014859 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:45.738965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:45.739310) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e3279760cd977aac30bd9e8032d3ee71f55d2a67 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e3279760cd977aac30bd9e8032d3ee71f55d2a67 --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=8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 18:16:46,008 truncating revision to first 12 chars 2016-10-31 18:16:46,008 Setting DEBUG logging. 2016-10-31 18:16:46,008 attempt 1/10 2016-10-31 18:16:46,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e3279760cd97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 18:16:46,329 unpacking tar archive at: fx-team-e3279760cd97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633788 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:46.386359) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:46.386709) ========= script_repo_revision: e3279760cd977aac30bd9e8032d3ee71f55d2a67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:46.387143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:46.387428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 18:16:46.399123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-31 18:16:46.399550) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:16:46 INFO - MultiFileLogger online at 20161031 18:16:46 in /builds/slave/test 18:16:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:16:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:16:46 INFO - {'append_to_log': False, 18:16:46 INFO - 'base_work_dir': '/builds/slave/test', 18:16:46 INFO - 'blob_upload_branch': 'Fx-Team', 18:16:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:16:46 INFO - 'branch': 'Fx-Team', 18:16:46 INFO - 'buildbot_json_path': 'buildprops.json', 18:16:46 INFO - 'config_files': ('talos/linux_config.py',), 18:16:46 INFO - 'default_actions': ('clobber', 18:16:46 INFO - 'read-buildbot-config', 18:16:46 INFO - 'download-and-extract', 18:16:46 INFO - 'populate-webroot', 18:16:46 INFO - 'create-virtualenv', 18:16:46 INFO - 'install', 18:16:46 INFO - 'run-tests'), 18:16:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:16:46 INFO - 'download_minidump_stackwalk': True, 18:16:46 INFO - 'download_symbols': 'ondemand', 18:16:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:16:46 INFO - 'tooltool.py': '/tools/tooltool.py', 18:16:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:16:46 INFO - '/tools/misc-python/virtualenv.py')}, 18:16:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:16:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:16:46 INFO - 'installer_path': 'installer.exe', 18:16:46 INFO - 'log_level': 'info', 18:16:46 INFO - 'log_name': 'talos', 18:16:46 INFO - 'log_to_console': True, 18:16:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:16:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:16:46 INFO - 'opt_config_files': (), 18:16:46 INFO - 'pip_index': False, 18:16:46 INFO - 'sps_profile': False, 18:16:46 INFO - 'sps_profile_interval': 0, 18:16:46 INFO - 'suite': 'dromaeojs', 18:16:46 INFO - 'system_bits': '32', 18:16:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:16:46 INFO - 'title': 'talos-linux64-ix-038', 18:16:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:16:46 INFO - 'use_talos_json': True, 18:16:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:16:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:16:46 INFO - 'work_dir': 'build'} 18:16:46 INFO - [mozharness: 2016-11-01 01:16:46.769411Z] Running clobber step. 18:16:46 INFO - Running pre-action listener: _resource_record_pre_action 18:16:46 INFO - Running main action method: clobber 18:16:46 INFO - rmtree: /builds/slave/test/build 18:16:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:16:47 INFO - Running post-action listener: _resource_record_post_action 18:16:47 INFO - [mozharness: 2016-11-01 01:16:47.783239Z] Finished clobber step (success) 18:16:47 INFO - [mozharness: 2016-11-01 01:16:47.783343Z] Running read-buildbot-config step. 18:16:47 INFO - Running pre-action listener: _resource_record_pre_action 18:16:47 INFO - Running main action method: read_buildbot_config 18:16:47 INFO - Using buildbot properties: 18:16:47 INFO - { 18:16:47 INFO - "project": "", 18:16:47 INFO - "product": "firefox", 18:16:47 INFO - "script_repo_revision": "production", 18:16:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:16:47 INFO - "repository": "", 18:16:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:16:47 INFO - "buildid": "20161031112308", 18:16:47 INFO - "stage_platform": "linux64-pgo", 18:16:47 INFO - "basedir": "/builds/slave/test", 18:16:47 INFO - "buildnumber": 1675, 18:16:47 INFO - "platform": "ubuntu64_hw", 18:16:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:16:47 INFO - "slavebuilddir": "test", 18:16:47 INFO - "branch": "fx-team", 18:16:47 INFO - "revision": "e3279760cd977aac30bd9e8032d3ee71f55d2a67", 18:16:47 INFO - "slavename": "talos-linux64-ix-038", 18:16:47 INFO - "builduid": "04404669c0d3437297eb5bc6c1d28a94", 18:16:47 INFO - "repo_path": "integration/fx-team" 18:16:47 INFO - } 18:16:47 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:16:47 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:16:47 INFO - Running post-action listener: _resource_record_post_action 18:16:47 INFO - [mozharness: 2016-11-01 01:16:47.785715Z] Finished read-buildbot-config step (success) 18:16:47 INFO - [mozharness: 2016-11-01 01:16:47.785802Z] Running download-and-extract step. 18:16:47 INFO - Running pre-action listener: _resource_record_pre_action 18:16:47 INFO - Running main action method: download_and_extract 18:16:47 INFO - mkdir: /builds/slave/test/build/tests 18:16:47 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')]} 18:16:47 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:16:47 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/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 18:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/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 18:16:47 INFO - Downloaded 1361 bytes. 18:16:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:16:47 INFO - Using the following test package requirements: 18:16:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:16:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:16:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:47 INFO - u'jsshell-linux-x86_64.zip'], 18:16:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:16:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:16:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:16:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:16:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:16:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:16:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:16:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:16:47 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:16:47 INFO - Http code: 200 18:16:47 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 18:16:47 INFO - x-amz-cf-id: iFTizWLoAt-AuNCTR7AalrA1bj0ES57CMP-HRRSBJc8tCa42AdUEQQ== 18:16:47 INFO - x-amz-replication-status: COMPLETED 18:16:47 INFO - x-amz-version-id: Hzq7d43DH4UQu9YX.EFymwfL1RGL4iTP 18:16:48 INFO - Expected file size: 22006771 18:16:48 INFO - Obtained file size: 22006771 18:16:52 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 18:16:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:16:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:16:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:16:52 INFO - Http code: 200 18:16:52 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 18:16:52 INFO - x-amz-cf-id: G3c6m29JVBpP9RZHhTGkrCahMNxAfj5begAp6f8lnFUKD8iwFy8xDw== 18:16:52 INFO - x-amz-replication-status: COMPLETED 18:16:52 INFO - x-amz-version-id: Hzq7d43DH4UQu9YX.EFymwfL1RGL4iTP 18:16:52 INFO - Expected file size: 22006771 18:16:52 INFO - Obtained file size: 22006771 18:16:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:16:57 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:16:57 INFO - Http code: 200 18:16:57 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 18:16:57 INFO - x-amz-cf-id: WDXoRZJ5SOd1i5aOss5Hk63I9GNsjrwBkDxDK3IK6pGB57AAfEBz_Q== 18:16:57 INFO - x-amz-replication-status: COMPLETED 18:16:57 INFO - x-amz-version-id: V2jS._gp16kUA7TDd4OV.rgL7vgwQgLs 18:16:57 INFO - Expected file size: 14409038 18:16:57 INFO - Obtained file size: 14409038 18:16:57 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')]} 18:16:57 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:16:57 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/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 18:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/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 18:16:58 INFO - Downloaded 59632897 bytes. 18:16:58 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:16:58 INFO - mkdir: /builds/slave/test/properties 18:16:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:16:58 INFO - Writing to file /builds/slave/test/properties/build_url 18:16:58 INFO - Contents: 18:16:58 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:16:58 INFO - Running post-action listener: _resource_record_post_action 18:16:58 INFO - Running post-action listener: set_extra_try_arguments 18:16:58 INFO - [mozharness: 2016-11-01 01:16:58.817167Z] Finished download-and-extract step (success) 18:16:58 INFO - [mozharness: 2016-11-01 01:16:58.817400Z] Running populate-webroot step. 18:16:58 INFO - Running pre-action listener: _resource_record_pre_action 18:16:58 INFO - Running main action method: populate_webroot 18:16:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:16:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:16:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:16:58 INFO - '--tppagecycles', 18:16:58 INFO - '7'], 18:16:58 INFO - 'tests': ['tsvgm']}}, 18:16:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:16:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:16:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:16:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:16:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:58 INFO - 'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:16:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:16:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:58 INFO - 'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['damp', 'tps']}, 18:16:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:58 INFO - 'tests': ['damp', 'tps']}, 18:16:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['dromaeo_dom']}, 18:16:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:16:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['basic_compositor_video']}, 18:16:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:16:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['a11yr', 18:16:58 INFO - 'ts_paint', 18:16:58 INFO - 'tpaint', 18:16:58 INFO - 'sessionrestore', 18:16:58 INFO - 'sessionrestore_no_auto_restore', 18:16:58 INFO - 'tabpaint']}, 18:16:58 INFO - 'other-e10s': {'tests': ['a11yr', 18:16:58 INFO - 'ts_paint', 18:16:58 INFO - 'tpaint', 18:16:58 INFO - 'sessionrestore', 18:16:58 INFO - 'sessionrestore_no_auto_restore', 18:16:58 INFO - 'tabpaint']}, 18:16:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:16:58 INFO - 'ts_paint', 18:16:58 INFO - 'tpaint', 18:16:58 INFO - 'sessionrestore', 18:16:58 INFO - 'sessionrestore_no_auto_restore', 18:16:58 INFO - 'tabpaint']}, 18:16:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:16:58 INFO - 'ts_paint', 18:16:58 INFO - 'tpaint', 18:16:58 INFO - 'sessionrestore', 18:16:58 INFO - 'sessionrestore_no_auto_restore', 18:16:58 INFO - 'tabpaint']}, 18:16:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['a11yr', 18:16:58 INFO - 'ts_paint', 18:16:58 INFO - 'tpaint', 18:16:58 INFO - 'sessionrestore', 18:16:58 INFO - 'sessionrestore_no_auto_restore', 18:16:58 INFO - 'tabpaint']}, 18:16:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['a11yr', 18:16:58 INFO - 'ts_paint', 18:16:58 INFO - 'tpaint', 18:16:58 INFO - 'sessionrestore', 18:16:58 INFO - 'sessionrestore_no_auto_restore', 18:16:58 INFO - 'tabpaint']}, 18:16:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['tsvgx', 18:16:58 INFO - 'tsvgr_opacity', 18:16:58 INFO - 'tart', 18:16:58 INFO - 'tscrollx', 18:16:58 INFO - 'cart']}, 18:16:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:16:58 INFO - 'tsvgr_opacity', 18:16:58 INFO - 'tart', 18:16:58 INFO - 'tscrollx', 18:16:58 INFO - 'cart']}, 18:16:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:58 INFO - 'talos_options': ['--disable-e10s'], 18:16:58 INFO - 'tests': ['tp5o']}, 18:16:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:58 INFO - 'tests': ['tp5o']}, 18:16:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:58 INFO - 'talos_options': ['--disable-e10s', 18:16:58 INFO - '--xperf_path', 18:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:16:58 INFO - 'tests': ['tp5n']}, 18:16:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:58 INFO - 'talos_options': ['--xperf_path', 18:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:16:58 INFO - 'tests': ['tp5n']}}, 18:16:58 INFO - 'talos.zip': {'path': '', 18:16:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:16:58 INFO - Running post-action listener: _resource_record_post_action 18:16:58 INFO - [mozharness: 2016-11-01 01:16:58.838130Z] Finished populate-webroot step (success) 18:16:58 INFO - [mozharness: 2016-11-01 01:16:58.838218Z] Running create-virtualenv step. 18:16:58 INFO - Running pre-action listener: _resource_record_pre_action 18:16:58 INFO - Running main action method: create_virtualenv 18:16:58 INFO - Creating virtualenv /builds/slave/test/build/venv 18:16:58 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 18:16:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:16:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:16:58 INFO - Using real prefix '/usr' 18:16:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:16:59 INFO - Installing distribute.............................................................................................................................................................................................done. 18:17:01 INFO - Installing pip.................done. 18:17:01 INFO - Return code: 0 18:17:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:17:01 INFO - Reading from file tmpfile_stdout 18:17:01 INFO - Output received: 18:17:01 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) 18:17:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:17:01 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')]} 18:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:01 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')]} 18:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:01 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 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:01 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 18:17:01 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 18:17:01 INFO - Using env: {'DISPLAY': ':0', 18:17:01 INFO - 'HOME': '/home/cltbld', 18:17:01 INFO - 'LANG': 'en_US.UTF-8', 18:17:01 INFO - 'LANGUAGE': 'en_US:en', 18:17:01 INFO - 'LOGNAME': 'cltbld', 18:17:01 INFO - 'MAIL': '/var/mail/cltbld', 18:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:01 INFO - 'MOZ_NO_REMOTE': '1', 18:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:01 INFO - 'NO_EM_RESTART': '1', 18:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:01 INFO - 'PWD': '/builds/slave/test', 18:17:01 INFO - 'SHELL': '/bin/bash', 18:17:01 INFO - 'SHLVL': '1', 18:17:01 INFO - 'TERM': 'linux', 18:17:01 INFO - 'TMOUT': '86400', 18:17:01 INFO - 'USER': 'cltbld', 18:17:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:01 INFO - '_': '/tools/buildbot/bin/python'} 18:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:01 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 18:17:01 INFO - Cleaning up... 18:17:01 INFO - Return code: 0 18:17:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:17:01 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')]} 18:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:01 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')]} 18:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:01 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 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:01 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 18:17:01 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 18:17:01 INFO - Using env: {'DISPLAY': ':0', 18:17:01 INFO - 'HOME': '/home/cltbld', 18:17:01 INFO - 'LANG': 'en_US.UTF-8', 18:17:01 INFO - 'LANGUAGE': 'en_US:en', 18:17:01 INFO - 'LOGNAME': 'cltbld', 18:17:01 INFO - 'MAIL': '/var/mail/cltbld', 18:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:01 INFO - 'MOZ_NO_REMOTE': '1', 18:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:01 INFO - 'NO_EM_RESTART': '1', 18:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:01 INFO - 'PWD': '/builds/slave/test', 18:17:01 INFO - 'SHELL': '/bin/bash', 18:17:01 INFO - 'SHLVL': '1', 18:17:01 INFO - 'TERM': 'linux', 18:17:01 INFO - 'TMOUT': '86400', 18:17:01 INFO - 'USER': 'cltbld', 18:17:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:01 INFO - '_': '/tools/buildbot/bin/python'} 18:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:02 INFO - Downloading/unpacking psutil>=3.1.1 18:17:02 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 18:17:02 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 18:17:02 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 18:17:02 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 18:17:02 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 18:17:02 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 18:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:04 INFO - Installing collected packages: psutil 18:17:04 INFO - Running setup.py install for psutil 18:17:04 INFO - building 'psutil._psutil_linux' extension 18:17:04 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 18:17:04 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 18:17:04 INFO - building 'psutil._psutil_posix' extension 18:17:04 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 18:17:04 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 18:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:04 INFO - Successfully installed psutil 18:17:04 INFO - Cleaning up... 18:17:04 INFO - Return code: 0 18:17:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:17:04 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')]} 18:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:04 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')]} 18:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:04 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 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:04 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 18:17:04 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 18:17:04 INFO - Using env: {'DISPLAY': ':0', 18:17:04 INFO - 'HOME': '/home/cltbld', 18:17:04 INFO - 'LANG': 'en_US.UTF-8', 18:17:04 INFO - 'LANGUAGE': 'en_US:en', 18:17:04 INFO - 'LOGNAME': 'cltbld', 18:17:04 INFO - 'MAIL': '/var/mail/cltbld', 18:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:04 INFO - 'MOZ_NO_REMOTE': '1', 18:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:04 INFO - 'NO_EM_RESTART': '1', 18:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:04 INFO - 'PWD': '/builds/slave/test', 18:17:04 INFO - 'SHELL': '/bin/bash', 18:17:04 INFO - 'SHLVL': '1', 18:17:04 INFO - 'TERM': 'linux', 18:17:04 INFO - 'TMOUT': '86400', 18:17:04 INFO - 'USER': 'cltbld', 18:17:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:04 INFO - '_': '/tools/buildbot/bin/python'} 18:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:17:06 INFO - Installing collected packages: mozsystemmonitor 18:17:06 INFO - Running setup.py install for mozsystemmonitor 18:17:06 INFO - Successfully installed mozsystemmonitor 18:17:06 INFO - Cleaning up... 18:17:07 INFO - Return code: 0 18:17:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:17: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')]} 18:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17: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')]} 18:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:17:07 INFO - Using env: {'DISPLAY': ':0', 18:17:07 INFO - 'HOME': '/home/cltbld', 18:17:07 INFO - 'LANG': 'en_US.UTF-8', 18:17:07 INFO - 'LANGUAGE': 'en_US:en', 18:17:07 INFO - 'LOGNAME': 'cltbld', 18:17:07 INFO - 'MAIL': '/var/mail/cltbld', 18:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:07 INFO - 'MOZ_NO_REMOTE': '1', 18:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:07 INFO - 'NO_EM_RESTART': '1', 18:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:07 INFO - 'PWD': '/builds/slave/test', 18:17:07 INFO - 'SHELL': '/bin/bash', 18:17:07 INFO - 'SHLVL': '1', 18:17:07 INFO - 'TERM': 'linux', 18:17:07 INFO - 'TMOUT': '86400', 18:17:07 INFO - 'USER': 'cltbld', 18:17:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:07 INFO - '_': '/tools/buildbot/bin/python'} 18:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:07 INFO - Downloading/unpacking jsonschema==2.5.1 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:17:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:17:09 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 18:17:09 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 18:17:09 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 18:17:09 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 18:17:09 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 18:17:09 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 18:17:09 INFO - Downloading functools32-3.2.3-2.tar.gz 18:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:17:09 INFO - warning: no files found matching '*.txt' 18:17:09 INFO - no previously-included directories found matching 'build' 18:17:09 INFO - no previously-included directories found matching 'dist' 18:17:09 INFO - no previously-included directories found matching '.git*' 18:17:09 INFO - Installing collected packages: jsonschema, functools32 18:17:09 INFO - Running setup.py install for functools32 18:17:09 INFO - warning: no files found matching '*.txt' 18:17:09 INFO - no previously-included directories found matching 'build' 18:17:09 INFO - no previously-included directories found matching 'dist' 18:17:09 INFO - no previously-included directories found matching '.git*' 18:17:09 INFO - Successfully installed jsonschema functools32 18:17:09 INFO - Cleaning up... 18:17:09 INFO - Return code: 0 18:17:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:17:09 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')]} 18:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:09 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')]} 18:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:09 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 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:09 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 18:17:09 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 18:17:09 INFO - Using env: {'DISPLAY': ':0', 18:17:09 INFO - 'HOME': '/home/cltbld', 18:17:09 INFO - 'LANG': 'en_US.UTF-8', 18:17:09 INFO - 'LANGUAGE': 'en_US:en', 18:17:09 INFO - 'LOGNAME': 'cltbld', 18:17:09 INFO - 'MAIL': '/var/mail/cltbld', 18:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:09 INFO - 'MOZ_NO_REMOTE': '1', 18:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:09 INFO - 'NO_EM_RESTART': '1', 18:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:09 INFO - 'PWD': '/builds/slave/test', 18:17:09 INFO - 'SHELL': '/bin/bash', 18:17:09 INFO - 'SHLVL': '1', 18:17:09 INFO - 'TERM': 'linux', 18:17:09 INFO - 'TMOUT': '86400', 18:17:09 INFO - 'USER': 'cltbld', 18:17:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:09 INFO - '_': '/tools/buildbot/bin/python'} 18:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:17:09 INFO - Cleaning up... 18:17:09 INFO - Return code: 0 18:17:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:17:09 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')]} 18:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:09 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')]} 18:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:09 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 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:09 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 18:17:09 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 18:17:09 INFO - Using env: {'DISPLAY': ':0', 18:17:09 INFO - 'HOME': '/home/cltbld', 18:17:09 INFO - 'LANG': 'en_US.UTF-8', 18:17:09 INFO - 'LANGUAGE': 'en_US:en', 18:17:09 INFO - 'LOGNAME': 'cltbld', 18:17:09 INFO - 'MAIL': '/var/mail/cltbld', 18:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:09 INFO - 'MOZ_NO_REMOTE': '1', 18:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:09 INFO - 'NO_EM_RESTART': '1', 18:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:09 INFO - 'PWD': '/builds/slave/test', 18:17:09 INFO - 'SHELL': '/bin/bash', 18:17:09 INFO - 'SHLVL': '1', 18:17:09 INFO - 'TERM': 'linux', 18:17:09 INFO - 'TMOUT': '86400', 18:17:09 INFO - 'USER': 'cltbld', 18:17:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:09 INFO - '_': '/tools/buildbot/bin/python'} 18:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:10 INFO - Downloading/unpacking blobuploader==1.2.4 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17:12 INFO - Downloading blobuploader-1.2.4.tar.gz 18:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:17:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:17:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17:12 INFO - Downloading docopt-0.6.1.tar.gz 18:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:17:12 INFO - Installing collected packages: blobuploader, requests, docopt 18:17:12 INFO - Running setup.py install for blobuploader 18:17:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:17:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:17:12 INFO - Running setup.py install for requests 18:17:13 INFO - Running setup.py install for docopt 18:17:13 INFO - Successfully installed blobuploader requests docopt 18:17:13 INFO - Cleaning up... 18:17:13 INFO - Return code: 0 18:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:13 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 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:13 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 18:17:13 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 18:17:13 INFO - Using env: {'DISPLAY': ':0', 18:17:13 INFO - 'HOME': '/home/cltbld', 18:17:13 INFO - 'LANG': 'en_US.UTF-8', 18:17:13 INFO - 'LANGUAGE': 'en_US:en', 18:17:13 INFO - 'LOGNAME': 'cltbld', 18:17:13 INFO - 'MAIL': '/var/mail/cltbld', 18:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:13 INFO - 'MOZ_NO_REMOTE': '1', 18:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:13 INFO - 'NO_EM_RESTART': '1', 18:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:13 INFO - 'PWD': '/builds/slave/test', 18:17:13 INFO - 'SHELL': '/bin/bash', 18:17:13 INFO - 'SHLVL': '1', 18:17:13 INFO - 'TERM': 'linux', 18:17:13 INFO - 'TMOUT': '86400', 18:17:13 INFO - 'USER': 'cltbld', 18:17:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:13 INFO - '_': '/tools/buildbot/bin/python'} 18:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:13 INFO - Running setup.py (path:/tmp/pip-Jw6e9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:13 INFO - Running setup.py (path:/tmp/pip-P_oOPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:13 INFO - Running setup.py (path:/tmp/pip-pEMKwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:13 INFO - Running setup.py (path:/tmp/pip-TERjOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:13 INFO - Running setup.py (path:/tmp/pip-IzjGnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:14 INFO - Running setup.py (path:/tmp/pip-fItLGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:14 INFO - Running setup.py (path:/tmp/pip-bYJxCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:14 INFO - Running setup.py (path:/tmp/pip-RL3vS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:14 INFO - Running setup.py (path:/tmp/pip-jxNegM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:14 INFO - Running setup.py (path:/tmp/pip-CMYj8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:14 INFO - Running setup.py (path:/tmp/pip-XyFQ3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:14 INFO - Running setup.py (path:/tmp/pip-QoVf30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:14 INFO - Running setup.py (path:/tmp/pip-XzDD19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:14 INFO - Running setup.py (path:/tmp/pip-eBqZkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:14 INFO - Running setup.py (path:/tmp/pip-s717cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:14 INFO - Running setup.py (path:/tmp/pip-FopfgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:14 INFO - Running setup.py (path:/tmp/pip-sMA28U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:17:14 INFO - Running setup.py install for manifestparser 18:17:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:17:14 INFO - Running setup.py install for mozcrash 18:17:15 INFO - Running setup.py install for mozdebug 18:17:15 INFO - Running setup.py install for mozdevice 18:17:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:17:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:17:15 INFO - Running setup.py install for mozfile 18:17:15 INFO - Running setup.py install for mozhttpd 18:17:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:17:15 INFO - Running setup.py install for mozinfo 18:17:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:17:15 INFO - Running setup.py install for mozInstall 18:17:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:17:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:17:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:17:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:17:15 INFO - Running setup.py install for mozleak 18:17:15 INFO - Running setup.py install for mozlog 18:17:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:17:15 INFO - Running setup.py install for moznetwork 18:17:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:17:16 INFO - Running setup.py install for mozprocess 18:17:16 INFO - Running setup.py install for mozprofile 18:17:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:17:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:17:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:17:16 INFO - Running setup.py install for mozrunner 18:17:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:17:16 INFO - Running setup.py install for mozscreenshot 18:17:16 INFO - Running setup.py install for moztest 18:17:16 INFO - Running setup.py install for mozversion 18:17:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:17:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:17:16 INFO - Cleaning up... 18:17:16 INFO - Return code: 0 18:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:16 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 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:16 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 18:17:16 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 18:17:16 INFO - Using env: {'DISPLAY': ':0', 18:17:16 INFO - 'HOME': '/home/cltbld', 18:17:16 INFO - 'LANG': 'en_US.UTF-8', 18:17:16 INFO - 'LANGUAGE': 'en_US:en', 18:17:16 INFO - 'LOGNAME': 'cltbld', 18:17:16 INFO - 'MAIL': '/var/mail/cltbld', 18:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:16 INFO - 'MOZ_NO_REMOTE': '1', 18:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:16 INFO - 'NO_EM_RESTART': '1', 18:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:16 INFO - 'PWD': '/builds/slave/test', 18:17:16 INFO - 'SHELL': '/bin/bash', 18:17:16 INFO - 'SHLVL': '1', 18:17:16 INFO - 'TERM': 'linux', 18:17:16 INFO - 'TMOUT': '86400', 18:17:16 INFO - 'USER': 'cltbld', 18:17:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:16 INFO - '_': '/tools/buildbot/bin/python'} 18:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:16 INFO - Running setup.py (path:/tmp/pip-YPWn0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:17 INFO - Running setup.py (path:/tmp/pip-pZ8ouY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:17 INFO - Running setup.py (path:/tmp/pip-O2A3XG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:17 INFO - Running setup.py (path:/tmp/pip-od821X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:17 INFO - Running setup.py (path:/tmp/pip-fOsmwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:17 INFO - Running setup.py (path:/tmp/pip-ejs3MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:17 INFO - Running setup.py (path:/tmp/pip-UajyFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:17 INFO - Running setup.py (path:/tmp/pip-Abz5L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:17 INFO - Running setup.py (path:/tmp/pip-e4hKZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:17 INFO - Running setup.py (path:/tmp/pip-jRVPXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:17 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)) 18:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:17 INFO - Running setup.py (path:/tmp/pip-Bxuz1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:18 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)) 18:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:18 INFO - Running setup.py (path:/tmp/pip-IyEVnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:18 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)) 18:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:18 INFO - Running setup.py (path:/tmp/pip-JTQIXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:18 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)) 18:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:18 INFO - Running setup.py (path:/tmp/pip-AMarkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:18 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)) 18:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:18 INFO - Running setup.py (path:/tmp/pip-kE7h9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:18 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)) 18:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:18 INFO - Running setup.py (path:/tmp/pip-karUZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:18 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)) 18:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:18 INFO - Running setup.py (path:/tmp/pip-FujQTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:18 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)) 18:17:18 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)) 18:17:18 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)) 18:17:18 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)) 18:17:18 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)) 18:17:18 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)) 18:17:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17: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 18:17:20 INFO - Downloading blessings-1.6.tar.gz 18:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:17:20 INFO - Installing collected packages: blessings 18:17:20 INFO - Running setup.py install for blessings 18:17:20 INFO - Successfully installed blessings 18:17:20 INFO - Cleaning up... 18:17:20 INFO - Return code: 0 18:17:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:20 INFO - Reading from file tmpfile_stdout 18:17:20 INFO - Current package versions: 18:17:20 INFO - argparse == 1.2.1 18:17:20 INFO - blessings == 1.6 18:17:20 INFO - blobuploader == 1.2.4 18:17:20 INFO - docopt == 0.6.1 18:17:20 INFO - functools32 == 3.2.3-2 18:17:20 INFO - jsonschema == 2.5.1 18:17:20 INFO - manifestparser == 1.1 18:17:20 INFO - mozInstall == 1.12 18:17:20 INFO - mozcrash == 0.17 18:17:20 INFO - mozdebug == 0.1 18:17:20 INFO - mozdevice == 0.48 18:17:20 INFO - mozfile == 1.2 18:17:20 INFO - mozhttpd == 0.7 18:17:20 INFO - mozinfo == 0.9 18:17:20 INFO - mozleak == 0.1 18:17:20 INFO - mozlog == 3.4 18:17:20 INFO - moznetwork == 0.27 18:17:20 INFO - mozprocess == 0.23 18:17:20 INFO - mozprofile == 0.28 18:17:20 INFO - mozrunner == 6.12 18:17:20 INFO - mozscreenshot == 0.1 18:17:20 INFO - mozsystemmonitor == 0.3 18:17:20 INFO - moztest == 0.7 18:17:20 INFO - mozversion == 1.4 18:17:20 INFO - psutil == 3.1.1 18:17:20 INFO - requests == 1.2.3 18:17:20 INFO - wsgiref == 0.1.2 18:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:20 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 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:20 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 18:17:20 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 18:17:20 INFO - Using env: {'DISPLAY': ':0', 18:17:20 INFO - 'HOME': '/home/cltbld', 18:17:20 INFO - 'LANG': 'en_US.UTF-8', 18:17:20 INFO - 'LANGUAGE': 'en_US:en', 18:17:20 INFO - 'LOGNAME': 'cltbld', 18:17:20 INFO - 'MAIL': '/var/mail/cltbld', 18:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:20 INFO - 'MOZ_NO_REMOTE': '1', 18:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:20 INFO - 'NO_EM_RESTART': '1', 18:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:20 INFO - 'PWD': '/builds/slave/test', 18:17:20 INFO - 'SHELL': '/bin/bash', 18:17:20 INFO - 'SHLVL': '1', 18:17:20 INFO - 'TERM': 'linux', 18:17:20 INFO - 'TMOUT': '86400', 18:17:20 INFO - 'USER': 'cltbld', 18:17:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:20 INFO - '_': '/tools/buildbot/bin/python'} 18:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:21 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)) 18:17:21 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)) 18:17:21 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)) 18:17:21 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)) 18:17:21 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)) 18:17:21 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)) 18:17:21 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)) 18:17:21 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)) 18:17:21 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)) 18:17:21 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)) 18:17:21 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)) 18:17:21 INFO - Cleaning up... 18:17:21 INFO - Return code: 0 18:17:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93bd196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e47b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, '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': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', '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 18:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:17:21 INFO - Using env: {'DISPLAY': ':0', 18:17:21 INFO - 'HOME': '/home/cltbld', 18:17:21 INFO - 'LANG': 'en_US.UTF-8', 18:17:21 INFO - 'LANGUAGE': 'en_US:en', 18:17:21 INFO - 'LOGNAME': 'cltbld', 18:17:21 INFO - 'MAIL': '/var/mail/cltbld', 18:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:21 INFO - 'MOZ_NO_REMOTE': '1', 18:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:21 INFO - 'NO_EM_RESTART': '1', 18:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:21 INFO - 'PWD': '/builds/slave/test', 18:17:21 INFO - 'SHELL': '/bin/bash', 18:17:21 INFO - 'SHLVL': '1', 18:17:21 INFO - 'TERM': 'linux', 18:17:21 INFO - 'TMOUT': '86400', 18:17:21 INFO - 'USER': 'cltbld', 18:17:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:21 INFO - '_': '/tools/buildbot/bin/python'} 18:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:17:21 INFO - Cleaning up... 18:17:21 INFO - Return code: 0 18:17:21 INFO - Running post-action listener: _resource_record_post_action 18:17:21 INFO - Running post-action listener: _start_resource_monitoring 18:17:21 INFO - Starting resource monitoring. 18:17:21 INFO - [mozharness: 2016-11-01 01:17:21.369941Z] Finished create-virtualenv step (success) 18:17:21 INFO - [mozharness: 2016-11-01 01:17:21.370407Z] Running install step. 18:17:21 INFO - Running pre-action listener: _resource_record_pre_action 18:17:21 INFO - Running main action method: install 18:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:21 INFO - Reading from file tmpfile_stdout 18:17:21 INFO - Detecting whether we're running mozinstall >=1.0... 18:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:17:21 INFO - Reading from file tmpfile_stdout 18:17:21 INFO - Output received: 18:17:21 INFO - Usage: mozinstall [options] installer 18:17:21 INFO - Options: 18:17:21 INFO - -h, --help show this help message and exit 18:17:21 INFO - -d DEST, --destination=DEST 18:17:21 INFO - Directory to install application into. [default: 18:17:21 INFO - "/builds/slave/test"] 18:17:21 INFO - --app=APP Application being installed. [default: firefox] 18:17:21 INFO - mkdir: /builds/slave/test/build/application 18:17:21 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'] 18:17:21 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 18:17:38 INFO - Reading from file tmpfile_stdout 18:17:38 INFO - Output received: 18:17:38 INFO - /builds/slave/test/build/application/firefox/firefox 18:17:38 INFO - Running post-action listener: _resource_record_post_action 18:17:38 INFO - [mozharness: 2016-11-01 01:17:38.625853Z] Finished install step (success) 18:17:38 INFO - [mozharness: 2016-11-01 01:17:38.626128Z] Running run-tests step. 18:17:38 INFO - Running pre-action listener: _resource_record_pre_action 18:17:38 INFO - Running main action method: run_tests 18:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:17:38 INFO - Python 2.7.3 18:17:38 INFO - Return code: 0 18:17:38 INFO - grabbing minidump binary from tooltool 18:17:38 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')]} 18:17:38 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 0x1973790>, '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 0x1974690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1974b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:17:38 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 18:17:38 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 18:17:38 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 18:17:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:17:38 INFO - Return code: 0 18:17:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:17:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:17:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:17:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:17:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:17:38 INFO - Using env: {'DISPLAY': ':0', 18:17:38 INFO - 'HOME': '/home/cltbld', 18:17:38 INFO - 'LANG': 'en_US.UTF-8', 18:17:38 INFO - 'LANGUAGE': 'en_US:en', 18:17:38 INFO - 'LOGNAME': 'cltbld', 18:17:38 INFO - 'MAIL': '/var/mail/cltbld', 18:17:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:17:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:38 INFO - 'MOZ_NO_REMOTE': '1', 18:17:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:38 INFO - 'NO_EM_RESTART': '1', 18:17:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:38 INFO - 'PWD': '/builds/slave/test', 18:17:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:17:38 INFO - 'SHELL': '/bin/bash', 18:17:38 INFO - 'SHLVL': '1', 18:17:38 INFO - 'TERM': 'linux', 18:17:38 INFO - 'TMOUT': '86400', 18:17:38 INFO - 'USER': 'cltbld', 18:17:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968', 18:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:38 INFO - '_': '/tools/buildbot/bin/python'} 18:17:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:17:38 INFO - mozversion application_buildid: 20161030123004 18:17:38 INFO - mozversion application_changeset: e3279760cd977aac30bd9e8032d3ee71f55d2a67 18:17:38 INFO - mozversion application_display_name: Nightly 18:17:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:17:38 INFO - mozversion application_name: Firefox 18:17:38 INFO - mozversion application_remotingname: firefox 18:17:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:17:38 INFO - mozversion application_vendor: Mozilla 18:17:38 INFO - mozversion application_version: 52.0a1 18:17:38 INFO - mozversion platform_buildid: 20161030123004 18:17:38 INFO - mozversion platform_changeset: e3279760cd977aac30bd9e8032d3ee71f55d2a67 18:17:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:17:38 INFO - mozversion platform_version: 52.0a1 18:17:38 INFO - using testdate: 1477963058 18:17:38 INFO - actual date: 1477963058 18:17:38 INFO - starting webserver on 'localhost:42180' 18:17:38 INFO - SUITE-START | Running 2 tests 18:17:38 INFO - TEST-START | dromaeo_css 18:17:38 INFO - operating with platform_type : linux_ 18:17:38 INFO - Initialising browser for dromaeo_css test... 18:17:38 INFO - TEST-INFO | started process 21779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHIVvpX/profile http://localhost:42180/getInfo.html) 18:17:43 INFO - PROCESS | 21779 | __metrics Screen width/height:1600/1200 18:17:43 INFO - PROCESS | 21779 | colorDepth:24 18:17:43 INFO - PROCESS | 21779 | Browser inner width/height: 1024/697 18:17:43 INFO - PROCESS | 21779 | __metrics 18:17:44 INFO - PROCESS | 21779 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:17:44 INFO - PROCESS | 21779 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:17:44 INFO - PROCESS | 21779 | console.error: PushService: 18:17:44 INFO - PROCESS | 21779 | stateChangeProcessEnqueue: Error transitioning state 18:17:44 INFO - PROCESS | 21779 | UnknownError 18:17:45 INFO - TEST-INFO | 21779: exit 0 18:17:45 INFO - Browser initialized. 18:17:45 INFO - Running cycle 1/1 for dromaeo_css test... 18:17:45 INFO - TEST-INFO | started process 21863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHIVvpX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:57 INFO - PROCESS | 21863 | RSS: Main: 175120384 18:17:57 INFO - PROCESS | 21863 | 18:18:48 INFO - PROCESS | 21863 | 1477963128947 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] 18:21:00 INFO - PROCESS | 21863 | Cycle 1(1): loaded http://localhost:42180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42180/tests/dromaeo/cssquery-ext.html) 18:21:02 INFO - PROCESS | 21863 | RSS: Main: 281518080 18:21:02 INFO - PROCESS | 21863 | 18:24:04 INFO - PROCESS | 21863 | Cycle 1(1): loaded http://localhost:42180/tests/dromaeo/cssquery-ext.html (next: http://localhost:42180/tests/dromaeo/cssquery-jquery.html) 18:24:05 INFO - PROCESS | 21863 | RSS: Main: 273530880 18:24:05 INFO - PROCESS | 21863 | 18:27:07 INFO - PROCESS | 21863 | Cycle 1(1): loaded http://localhost:42180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42180/tests/dromaeo/cssquery-mootools.html) 18:27:07 INFO - PROCESS | 21863 | RSS: Main: 215724032 18:27:07 INFO - PROCESS | 21863 | 18:30:09 INFO - PROCESS | 21863 | Cycle 1(1): loaded http://localhost:42180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42180/tests/dromaeo/cssquery-prototype.html) 18:30:10 INFO - PROCESS | 21863 | RSS: Main: 254771200 18:30:10 INFO - PROCESS | 21863 | 18:33:13 INFO - PROCESS | 21863 | Cycle 1(1): loaded http://localhost:42180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42180/tests/dromaeo/cssquery-yui.html) 18:33:13 INFO - PROCESS | 21863 | RSS: Main: 217169920 18:33:13 INFO - PROCESS | 21863 | 18:36:16 INFO - PROCESS | 21863 | Cycle 1(1): loaded http://localhost:42180/tests/dromaeo/cssquery-yui.html (next: http://localhost:42180/tests/dromaeo/cssquery-dojo.html) 18:36:16 INFO - PROCESS | 21863 | RSS: Main: 310042624 18:36:16 INFO - PROCESS | 21863 | 18:36:16 INFO - PROCESS | 21863 | __start_tp_report 18:36:16 INFO - PROCESS | 21863 | _x_x_mozilla_page_load 18:36:16 INFO - PROCESS | 21863 | _x_x_mozilla_page_load_details 18:36:16 INFO - PROCESS | 21863 | |i|pagename|runs| 18:36:16 INFO - PROCESS | 21863 | |0;dojo.html;3058.388322335533;3084.3831233753253;3099.333643266698;3128.1866714654184;3148.6379066407358;5299.8410047698535;5385.865353366168;5403.2165336026355;5456.481634244746;5472.425395333487;5386.8922621547545;5393.514583687467;5394.271773310602;5399.1091469907415;5466.043442397585;4887.584555312794;4915;4947.802087916497;4971.850844474671;4991.201407774757;4954.7522623868845;4975.27858460523;5011.874703132415;5012.949870501285;5023.171176755849;5079.822206222783;5089.134847076006;5104.974475127638;5145.253938178962;5145.382554093514;5085.23721441783;5089.491050894918;5089.7455127243675;5091.567216786578;5148.150555158394;4823.324734537167;4925.458199598042;5027.421846487664;5033.546980771748;5034.395872495324;5433.483819037185;5452.836414907559;5458.645188062763;5466.207399926989;5532.3637781655225;5939.109133629947;5948.553858460589;5950.553708471839;5950.9883319835735;5953.226080609536;5687.60186786921;5738.139279108125;5808.59339846211;5870.324912635059;5963.344032156459;5449.855530338594;5466.125419932791;5470.781168753285;5473.042217611902;5511.200875872976;5986.341502434729;5993.130996005555;5995.490383317379;5997.220361353084;5999.5800293979;5552.333719953632;5618.4662457066515;5619.971900140473;5669.092945128759;5758.424157584292;5827.096799996008;5857.677827719516;5864.266966629171;5911.822645320647;5933.080372542263;5799.33307669615;5834.504067154255;5844.1818145459665;5845.649261044351;5853.268341457318;5664.461876121844;5730.398308177665;5798.478136967693;5861.853453663607;5907.025340818716;4425.690201685851;4450.287953927421;4455.7994890229365;4461.776911154429;4532.070925460339;3980.20395920817;3989.202159568098;3994.121293315466;4028.1742242840146;4031.899202519902;5586.91619625706;5595.328560572757;5603.2435621191435;5661.773529058792;5665.433456654301;5625.353084395347;5743.741531631086;5748.080307150836;5931.703414829241;5936.5250779937505;5458.590605704509;5517.282753242133;5540.63985840919;5622.493975542221;5624.409437009055;4993.775280112403;5030.547250747451;5041.420236672756;5047.192449208109;5105.821296254613;6041.909371359433;6058.363871793486;6071.787487438007;6075.149479073022;6076.3012253591405;5647.3787883333625;5720.6853623049465;5836.095405212199;5876.588638795243;5900.498457631149;6091.692560820238;6095.317435523607;6112.199536562638;6118.223266370627;6121.615429060945;5808.7095645218415;5821.476067153976;5823.417658234142;5823.475887170175;5883.499902508334;5686.09022556389;5758.395368486416;5775.931452681268;5873.530117590668;5927.881442371215;5647.802326918538;5688.971555142198;5718.428157184248;5720.3707592165665;5761.769529218785;5692.772289108555;5700.173474846041;5700.429957004267;5702.315722113207;5707.914381284201;5552.278203833475;5561.110222364564;5684.431556844283;5692.430756924275;5694.743736531783;5734.684592347461;5774.653520788598;5797.449242321973;5821.94178058231;5886.558508111823;5678.4605462480995;5688.14677798317;5697.914531282117;5699.971500142473;5700.914486282626 18:36:16 INFO - PROCESS | 21863 | |1;ext.html;569.1345603756092;582.8513728999104;607.5898768331376;610.6031079798131;639.0127253393507;31882;34934;43316.99999999996;44025.59744025596;44037.33943990843;44063;44498.77750611243;44516.77741611296;44549.7772511137;44556.77721611387;8854.645814167425;9009.549522523848;9021.819563608724;9024.23294020009;9024.413413128159;7986.560739159344;8183.222593853575;8190.631421586043;8393.916060839405;8822.911770882272;10551.894481055167;10790.190735694816;10791.62229321974;11218.102551795877;11232.326060436359;10805.459727013656;10875.782484350348;10879.401632910227;10882.945585272102;10883.292585981886;10539.683809485728;10727;10735.355878647306;10747.731306717316;10749.355038697704;42218.36672449916;42475.787621061696;42476.78761606172;42593.57406425958;42707.57292427067;3519.243362677011;3539;3651.790666646667;3866.5360156781367;4039.5354534228354;30461.847690761628;30624.693753062405;30745.231369215726;30802;30986.690133098833;4346.261135606923;4395.868123956287;4402.955970440319;4446.377507149002;4475.977620111911;356243;356622.2168889165;357304.05611466867;358556;359533;58031.38858751366;58285.708571456875;58552;58592.70703646455;58615.70692146512;31610.36779264448;32115.03654890357;32184.19539511531;32270;62721.68639156775;13919.860801392058;13956.09285396446;14017.229052402012;14018.228997405036;14022;11354.886451135382;11532.616086069725;11536;11550.653480395602;11632.069434445224;16388.44309790568;16719.414820481226;18235;18791.812081879005;19124.505741150817;6919.411849992807;7055.89416158758;7058.188308344504;7181.281871812881;7196.712131514785;929.3355250995571;990.1385794358954;1032.3031953431405;1050.558765318568;1081.551156270139;31087;31221;31292.53061204084;31365.843170784457;32005.35989280248;1048.9685309440729;1075.5160177919968;1092.819684752023;1115.827046807746;1118.4854966715238;15930.522084337488;16614.83385166133;16758;16781.664366712597;16785.160741962853;570063;577058;578372;578455;580386;48726.26910596344;48875.26687099625;53294.73352633212;54048.729756350964;54155.72922135443;1285.4022879361141;1306.7125232448846;1310.8361454818148;1323.358171286925;1331.8202042724301;30079.26076393041;32306;32375;32444.35111297808;32710;49498.50501494939;50062;50079.74960125176;50152;51931.74034129805;369904;529384;530672;531156;532444;40597.39103913503;40687.38968915528;40872;41217.58782412137;41728.16543669171;45121;45851.77074114608;45857.541424585324;49173;50055;37843.62156378511;41866.790666047695;41925.1614967705;42026.159476810906;43841.12317753691;42001.57998420099;42104.3684344729;42256.1548769029;42721.572784273005;43325.56674433215;40958.38562421626;41716.374254386814;43102.35346469743;43190.35214471848;43312.566874332115;34828.477572835924;37113.257734844614;37682.767167371385;38095.809520952214;38309.4253586202;28415.715842842135;28965.85517072401;29043;29097.85451072731;29098 18:36:16 INFO - PROCESS | 21863 | |2;jquery.html;360.20934049760785;378.4984895014107;389.54423324710086;390.1475276520802;411.5945793393507;14266.286685665727;18055.4583362499;18469;18502.62994740106;19815.5046123847;18487.537811554717;19135.904320478414;19301.420957371265;19306;19351.709724354147;5487.890242195153;5738.856528586798;5753.367129615739;5757.942420575782;5758.712064396764;4064.817083231247;4272.9359059614135;4334.934975975347;5591.329040515144;5705;6296;6411.006294024411;6421.550491465576;6425.22897252328;6425.935740642581;6161.229846269216;6236.126942228115;6281.057841323793;6290.182276304097;6418.165638466993;5571.164325351189;5574.665520068809;5575;5578.30271216098;5581.748821303051;23105.88447057771;23164.073437062496;23271.53456930869;23279.534409311887;23430.17994370189;2434.1358817619844;2623.3966187776728;2742.287005378596;2753;2813.9296517587018;13805.654858628513;14181.78727319091;14235.644108897257;14525.636859078502;14783.408663653441;1868.252698920429;1888.1031510032624;1926.1332400419867;1930.4691209917244;1959.6472634925708;71734.1644822581;73073.26926730771;73592.26407735908;82337.58831205805;83832.58083709542;10638.734031649115;10739.83890241647;10947.233693641369;11201.818335210897;11219.719507012227;15551.611209719622;15585.454509092355;15616.687666246611;15636.296366663528;15638.687226255412;7392.519486233377;7639.770806875691;7678.923210767933;7798.064232292161;7811.101723301779;7080.221175670672;7106.71573137079;7107.609081500464;7340.082489688789;7397.482176247719;4645.9303110453375;4706;4745.406824146981;4782.808687652525;4829.9034019319415;1808.5478630342413;1860.144333606529;1942.2619404626153;1967.2917749610128;2004.2383894120433;816.5508970066439;833.2001278772325;845.7547311279783;942.4627962061559;958.4584709639032;18568.535786605175;18844.905775471034;19645.901770491055;19762.50593735168;19845.503862403555;894.3113802372137;915;959.3811991265594;971.4511301114989;984.4339504784634;8856.734297971072;10724.356538607708;10873.2059210231;10896.673099807018;10974.670759877217;469207;475601;482779;490748;490806;91699;92797.53601231951;93197.5340123295;93745.5312723432;95286.09427811405;954.3224310739314;978.1636700621009;1015.9898401015895;1016.420640235059;1021.1626466297713;16721.665566688356;16946.237419315912;17594.29622815124;18033.72949405786;18197.45407637773;39356.80321598374;43524;43632;43666.78166609147;44622.77688611666;57744.71127644335;59122;60644;61401.38598614135;61784.38215617966;8125.634346454305;8450.915490845013;8469.237768600855;8508;8788.868166977372;9766.023397660178;11762.882371176178;13142.934285328512;13215.537456189371;13716.65708357299;11723.179377443497;11764.82352764692;11856;12062.577809776616;12092.879071209176;11318.434078296217;11478.139139564399;11584.478698458759;11639.941800290944;11694.166396245793;10865.619703310345;11924.701882453008;12007.519699211934;12019.338936358585;12062.155649104478;7372.96313518429;7517.248275172439;7522.097348318237;8113.310368618733;8701.17338852808;11573;11687.88312116868;11794.646160615195;11823.645290641294;12364.56724014655 18:36:16 INFO - PROCESS | 21863 | |3;mootools.html;1418.6453386653334;1469.331454188344;1568.9912274139576;1723.6121872578678;1731.4978656189714;7369.336759691627;7604.391648668107;8003.199680031994;8506;8528.488290702555;7881.251281128284;8261.83476330473;8283.213094755989;8510.148985101487;8510.872336914952;2265.592193405186;2275.055851821492;2284.246198754415;2285.2116019973164;2289.919852805152;2014.1943222710959;2227.7438094619083;2280.1905323610126;2324.6861673674007;2327.569399661068;2012.0845015517978;2172.6849606807004;2230.096810791632;2265.0486795545826;2271.761465046163;2181.4219231903558;2210.7568167501563;2224.810891074261;2226.821854251672;2250.144944920936;2236.2396785092983;2254.3800454874877;2257.7177852768405;2261.5929132756096;2262.061244583496;8381.622826972802;8411.915880841174;8420.578971051424;8470.703525376583;8537.10360412154;4956.536900047331;4996.200607902718;5122.641415100945;5144.61415393847;5163.199704045879;3038.179691483287;3060.296131889678;3168.5088811234295;3175.4601717707815;3188.6333071696818;1047.9685609431729;1073;1110.6667999600088;1122.5004872831594;1124.2973141786383;11700;11703.94148029263;11712.355820429873;11713.53145874164;11791.882081179165;4327.891802704895;4497.145542346943;4617;4626.398568186114;4639.118567472169;9737.9775123611;9756.07317304855;9797.118259356692;9797.657082002095;9804.558794854249;5181.4041385240425;5187.377514698185;5195.532402083755;5195.7142357170715;5196.740162991835;4702.224133018014;4769.165396055676;4771.904561908743;4783.521647835259;4821.614270858393;3752.305823422621;3817.7136714746507;3828.674562662205;3907.238088572701;3914.549826769901;1162.604714397109;1221.2428294457493;1265.6772523006575;1270.4346565778326;1283.3006011723633;799.444386151619;943.094629156018;947.3652652722692;952.8237276103943;972.3776782858976;5586.24585680936;5638.746256418471;5694.032014557535;5729.512991395694;5734.340550836707;932.4778124250441;945.177695405002;950.292032435826;952.8523078922778;963.1043129889131;3862.3240932837202;3863.3818589025623;3864.4976153099915;3881.262560113569;3914.5106861642294;9820.607175712892;10257.435841028666;10269;10269.537870795832;10275.897241027644;10162.796744065077;10172.796544069077;10179.84730229047;10186.796264074825;10189.439580823126;7518.736844210426;7698.153203147649;7810.10183828867;7812.921870781333;7892.329152022143;5397.78408863641;5402.783888644411;5493.505584497414;5507.917381239365;5710.5146062585145;9433;9469.14777670013;9587.952060239653;9656.71029869105;9687.079727425884;9007.77480562965;9395.107464791108;9412.058794120534;9627.759306017126;9722.805543889224;7253.963730181315;7422.183559808309;7427.8143046424275;7431.925680743123;7433;7944.6424910877995;7997.880031799411;8061.113277539349;8128.75613731589;8229.382796290183;5781.624194427349;7074.68163932614;7150.856982860209;7157.785266442015;7332.78001659951;7150.070490836158;7207.891881621885;7228.421726261991;7373.668184931584;7444.962775186089;6735.528513004043;6791.117154769849;6838.350356716104;6840.076589660531;6913.654317284015;4738.8341408050555;4796.9760151199025;4836.540528649773;4914.655974081923;5071.264666623393;4778.163821331323;4806.327114204084;4838.2016967201425;4873.707577545359;4879.853604391874 18:36:16 INFO - PROCESS | 21863 | |4;prototype.html;313.2575795364984;325.342807528792;335.8387973772589;341.3667646515713;341.6839423533231;5190.754218987444;5345.705986170759;5355.437679043698;5422.674639521627;5434.864128396787;5186.196139598368;5286.814961476349;5314.92027619586;5318.27156174243;5331.960267747791;4144.52337981133;4153.854615088472;4166.333386658128;4169.374593810938;4183.5398106208295;4068.328725760246;4112.198121366335;4171.435711608147;4180.6237438630515;4181.268278051329;4124.298869192229;4134.710570260083;4139.979300103495;4146.647534959532;4150.792460376984;4144.129732756125;4146.3780432935;4148.274052040881;4150.481189851269;4161.459010328638;3670.9632903671154;3682.6317368263226;3684.3552378333684;3688.2807852468777;3694.7598406103516;5070.6957582545165;5217.660852044605;5234.659747116425;5248.343957005374;5251.973740131313;4739.928901066487;4741.502142275081;4746.050789842046;4754.453237877654;4785.760711964423;5401.972990135024;5540.889182216373;5574.526165275956;5653.886922261532;5655.519280861091;3977;3983.665472066861;3984.3625019996953;3989.98005009976;3992.820323085439;5748.770049198027;5770.365259821417;5784.826455206308;5795.710214489301;5818.3308919474375;4075.8573449929704;4087.2234275487563;4088.2232375848494;4104.8768536943935;4109.116539943926;4055.5741647127215;4137.482814648169;4146.170765846843;4151.418801367811;4174.036434131801;4699.765011749399;4699.85900422981;4704.882377940579;4706.270528068155;4730.716157030589;5633.887322253532;5636.408177141423;5637.746301416446;5649.971750141223;5656.60403771732;1330.6141219046563;1331.460758392833;1426.179946530749;1431.2128329418986;1439.0502268502737;894.2622336572354;913.4336711238941;923.422860712055;924.1405492891676;931.4504442379028;4856.562909338177;4885.828995985124;4891.190259603969;4897.363342765418;4900.779464924087;5110.572478072886;5111.309973153651;5114.872128196825;5124.769385377593;5125.846684496033;4730.290456431563;4804.42346918372;4831.275308703653;4877.9024419512125;5157.200633901752;3047.649520305149;3063.1423201503617;3078.3535457553717;3080.1375614827884;3120.485119955227;5909.6158749681135;5915.526757859361;5944.197533332945;5945.078512830518;5961.880762384815;5648.548116150698;5912.0144327115395;5928.644281343133;5972.552058595623;5980.970095149496;5988.640681559121;5991.820245392558;5997.790077347272;6027.819165425044;6029.784236635366;5572.777088916398;5786.161006654096;5790;5794.391588883106;5846;5731.971340143273;5749;5755.7122143893475;5768.221290125947;5781.364049954585;5945.197398351167;5950.9702451487465;5972.790952316648;5982.760689572368;5990.400959903975;3847.3651847444858;4001.459802926684;4027.033511957168;4039.212353591139;4053.6757059435763;5516.310461192351;5741.74162162712;5757.5393968481585;5780.971095144498;5791.797287094932;5533.529649979797;5573.498385145356;5576.749046293007;5588.239704493071;5637.154426836008;5629.577781666309;5650;5651.208830763779;5667.206591077335;5684.77260909559;5440.510354068153;5624.268845050281;5646.265985421869;5660.886782264414;5661.575381846295;5623.578231632726;5690.630109042899;5706.8573285666525;5721.656700597978;5721.971390143022;5443.265159203457;5573;5578.736439183123;5579.6652200868075;5588.217649528988 18:36:16 INFO - PROCESS | 21863 | |5;yui.html;649.8148027812075;656.3141517114615;690.9877030150828;694.992261221229;739.8076500109971;14564.271786410676;15322.080675159497;15377.999999999985;15522.379104835793;15565.610859728498;14791.40834366624;15578.376864925389;15636.061836289831;15637.765433518507;15640.217989100556;793.2186796005944;815.5881279953616;818.1327792539897;818.30444122496;818.950862948222;653.2128784814288;676.0872821690728;771.5910567399287;792.5957761541626;801.1107670485757;849.2611428057598;849.8470275350435;855.7903313688155;857.781265777229;858.0261403307229;853.4495250563414;853.4708480741917;853.6500034985626;854.1586537260794;854.4403415762686;497.72002503501733;513.6686836990158;518.9014087323434;519.1175002495772;589.8083122985047;13761.587152385344;14149.151050936976;14283.357248923823;14363.856361436356;14383.568492945229;13418.664533386645;13656.863431365658;13663.248521331323;13724.588262352045;13800;12288.754224915541;12585.307808070553;12826.486940522462;12882.227066375954;12905.03212259075;4389.978050109729;4401.867943961686;4412.227860124465;4428.911421771547;4442.600165985077;53748.46251537474;55463.445365546235;64686.353136468504;64819.351806481805;64969;10950.507227174796;10987.670369888916;11070.239796887416;11134.10927125828;11180;19647.607047858965;19788.802111978985;19876.70184947227;19888.403347899588;19986;7872.488288261245;8087.5551844647935;8163.38774591908;8197.385196110195;8338.291245244101;4297.613214810682;4326.199653064194;4372.278574035312;4443.555644435531;4447;3464.4456886897974;3569.39320315547;3570.2680950405106;3572.1962558424148;3572.2498275361945;589.9911501327483;593.6794131169206;602.9643270858649;608.2761513798565;617.8393617659351;639.0251889043772;693.1197379328225;706.9328413800681;726.9164046134656;770.6146926536732;9067.455952642862;9440.306279321088;9472.526373681289;9546.761330966781;9778.951105244429;558.4443478738681;607.0378450156551;624.1916717850395;633.4330773957374;712.3624356201171;4234.7670878102;4312.870613881589;4337.414449049338;4413.205622987893;4482.618977386894;72372.63813680898;78999;80363.59818200872;81812.59093704494;82530;45474.09051818945;45613.543864561594;46372.7681361591;46724;71461;65987;66799.66600166968;66899;67009.66495167493;67838.66080669565;8261;8434.789130271793;8453.873191902003;8473.406861519634;8542.103079176597;43001.56998430101;43231.78384108059;43474.34788478112;44577.33134003057;44913.550864490935;54361.72819135879;58932.410675892694;59131;59806;61015.69492152511;10721.785564288826;10905.945470272598;10925.46005586035;11723.941380293043;11788.351640659846;13609.251491168081;13833.170009799444;14070.648233794236;14151.716965660835;14512.709745805236;12786.936065319614;12998.610041698765;13246.933765331112;13632.727345453233;13784.172949623055;11405.942970285096;11802.940985295361;11820.645380638594;11987.22083064598;12071.939640302093;11958.282503049844;12111.576094836639;12275.877241227474;12808;12930.224186548838;10227.590896364061;10536.473176341306;10584.682459526226;10817;11050.171237157085;11301.773964520828;11365.54537818478;11389.202755807346;11442;11452.770944581229 18:36:16 INFO - PROCESS | 21863 | __end_tp_report 18:36:16 INFO - PROCESS | 21863 | __start_cc_report 18:36:16 INFO - PROCESS | 21863 | _x_x_mozilla_cycle_collect,980 18:36:16 INFO - PROCESS | 21863 | __end_cc_report 18:36:16 INFO - PROCESS | 21863 | __startTimestamp1477964176664__endTimestamp 18:36:16 INFO - PROCESS | 21863 | 18:36:16 INFO - PROCESS | 21863 | ------- Summary: start ------- 18:36:16 INFO - PROCESS | 21863 | Number of tests: 6 18:36:16 INFO - PROCESS | 21863 | 18:36:16 INFO - PROCESS | 21863 | [#0] dojo.html Cycles:165 Average:5439.95 Median:5664.46 stddev:620.43 (11.0%) stddev-sans-first:593.54 18:36:16 INFO - PROCESS | 21863 | Values: 3058.4 3084.4 3099.3 3128.2 3148.6 5299.8 5385.9 5403.2 5456.5 5472.4 5386.9 5393.5 5394.3 5399.1 5466.0 4887.6 4915.0 4947.8 4971.9 4991.2 4954.8 4975.3 5011.9 5012.9 5023.2 5079.8 5089.1 5105.0 5145.3 5145.4 5085.2 5089.5 5089.7 5091.6 5148.2 4823.3 4925.5 5027.4 5033.5 5034.4 5433.5 5452.8 5458.6 5466.2 5532.4 5939.1 5948.6 5950.6 5951.0 5953.2 5687.6 5738.1 5808.6 5870.3 5963.3 5449.9 5466.1 5470.8 5473.0 5511.2 5986.3 5993.1 5995.5 5997.2 5999.6 5552.3 5618.5 5620.0 5669.1 5758.4 5827.1 5857.7 5864.3 5911.8 5933.1 5799.3 5834.5 5844.2 5845.6 5853.3 5664.5 5730.4 5798.5 5861.9 5907.0 4425.7 4450.3 4455.8 4461.8 4532.1 3980.2 3989.2 3994.1 4028.2 4031.9 5586.9 5595.3 5603.2 5661.8 5665.4 5625.4 5743.7 5748.1 5931.7 5936.5 5458.6 5517.3 5540.6 5622.5 5624.4 4993.8 5030.5 5041.4 5047.2 5105.8 6041.9 6058.4 6071.8 6075.1 6076.3 5647.4 5720.7 5836.1 5876.6 5900.5 6091.7 6095.3 6112.2 6118.2 6121.6 5808.7 5821.5 5823.4 5823.5 5883.5 5686.1 5758.4 5775.9 5873.5 5927.9 5647.8 5689.0 5718.4 5720.4 5761.8 5692.8 5700.2 5700.4 5702.3 5707.9 5552.3 5561.1 5684.4 5692.4 5694.7 5734.7 5774.7 5797.4 5821.9 5886.6 5678.5 5688.1 5697.9 5700.0 5700.9 18:36:16 INFO - PROCESS | 21863 | 18:36:16 INFO - PROCESS | 21863 | [#1] ext.html Cycles:180 Average:62845.04 Median:22318.46 stddev:129777.43 (581.5%) stddev-sans-first:130057.26 18:36:16 INFO - PROCESS | 21863 | Values: 569.1 582.9 607.6 610.6 639.0 31882.0 34934.0 43317.0 44025.6 44037.3 44063.0 44498.8 44516.8 44549.8 44556.8 8854.6 9009.5 9021.8 9024.2 9024.4 7986.6 8183.2 8190.6 8393.9 8822.9 10551.9 10790.2 10791.6 11218.1 11232.3 10805.5 10875.8 10879.4 10882.9 10883.3 10539.7 10727.0 10735.4 10747.7 10749.4 42218.4 42475.8 42476.8 42593.6 42707.6 3519.2 3539.0 3651.8 3866.5 4039.5 30461.8 30624.7 30745.2 30802.0 30986.7 4346.3 4395.9 4403.0 4446.4 4476.0 356243.0 356622.2 357304.1 358556.0 359533.0 58031.4 58285.7 58552.0 58592.7 58615.7 31610.4 32115.0 32184.2 32270.0 62721.7 13919.9 13956.1 14017.2 14018.2 14022.0 11354.9 11532.6 11536.0 11550.7 11632.1 16388.4 16719.4 18235.0 18791.8 19124.5 6919.4 7055.9 7058.2 7181.3 7196.7 929.3 990.1 1032.3 1050.6 1081.6 31087.0 31221.0 31292.5 31365.8 32005.4 1049.0 1075.5 1092.8 1115.8 1118.5 15930.5 16614.8 16758.0 16781.7 16785.2 570063.0 577058.0 578372.0 578455.0 580386.0 48726.3 48875.3 53294.7 54048.7 54155.7 1285.4 1306.7 1310.8 1323.4 1331.8 30079.3 32306.0 32375.0 32444.4 32710.0 49498.5 50062.0 50079.7 50152.0 51931.7 369904.0 529384.0 530672.0 531156.0 532444.0 40597.4 40687.4 40872.0 41217.6 41728.2 45121.0 45851.8 45857.5 49173.0 50055.0 37843.6 41866.8 41925.2 42026.2 43841.1 42001.6 42104.4 42256.2 42721.6 43325.6 40958.4 41716.4 43102.4 43190.4 43312.6 34828.5 37113.3 37682.8 38095.8 38309.4 28415.7 28965.9 29043.0 29097.9 29098.0 18:36:16 INFO - PROCESS | 21863 | 18:36:16 INFO - PROCESS | 21863 | [#2] jquery.html Cycles:180 Average:28813.99 Median:21710.81 stddev:79490.64 (366.1%) stddev-sans-first:79684.93 18:36:16 INFO - PROCESS | 21863 | Values: 360.2 378.5 389.5 390.1 411.6 14266.3 18055.5 18469.0 18502.6 19815.5 18487.5 19135.9 19301.4 19306.0 19351.7 5487.9 5738.9 5753.4 5757.9 5758.7 4064.8 4272.9 4334.9 5591.3 5705.0 6296.0 6411.0 6421.6 6425.2 6425.9 6161.2 6236.1 6281.1 6290.2 6418.2 5571.2 5574.7 5575.0 5578.3 5581.7 23105.9 23164.1 23271.5 23279.5 23430.2 2434.1 2623.4 2742.3 2753.0 2813.9 13805.7 14181.8 14235.6 14525.6 14783.4 1868.3 1888.1 1926.1 1930.5 1959.6 71734.2 73073.3 73592.3 82337.6 83832.6 10638.7 10739.8 10947.2 11201.8 11219.7 15551.6 15585.5 15616.7 15636.3 15638.7 7392.5 7639.8 7678.9 7798.1 7811.1 7080.2 7106.7 7107.6 7340.1 7397.5 4645.9 4706.0 4745.4 4782.8 4829.9 1808.5 1860.1 1942.3 1967.3 2004.2 816.6 833.2 845.8 942.5 958.5 18568.5 18844.9 19645.9 19762.5 19845.5 894.3 915.0 959.4 971.5 984.4 8856.7 10724.4 10873.2 10896.7 10974.7 469207.0 475601.0 482779.0 490748.0 490806.0 91699.0 92797.5 93197.5 93745.5 95286.1 954.3 978.2 1016.0 1016.4 1021.2 16721.7 16946.2 17594.3 18033.7 18197.5 39356.8 43524.0 43632.0 43666.8 44622.8 57744.7 59122.0 60644.0 61401.4 61784.4 8125.6 8450.9 8469.2 8508.0 8788.9 9766.0 11762.9 13142.9 13215.5 13716.7 11723.2 11764.8 11856.0 12062.6 12092.9 11318.4 11478.1 11584.5 11639.9 11694.2 10865.6 11924.7 12007.5 12019.3 12062.2 7373.0 7517.2 7522.1 8113.3 8701.2 11573.0 11687.9 11794.6 11823.6 12364.6 18:36:16 INFO - PROCESS | 21863 | 18:36:16 INFO - PROCESS | 21863 | [#3] mootools.html Cycles:180 Average:5502.62 Median:5096.95 stddev:3081.61 (60.5%) stddev-sans-first:3074.98 18:36:16 INFO - PROCESS | 21863 | Values: 1418.6 1469.3 1569.0 1723.6 1731.5 7369.3 7604.4 8003.2 8506.0 8528.5 7881.3 8261.8 8283.2 8510.1 8510.9 2265.6 2275.1 2284.2 2285.2 2289.9 2014.2 2227.7 2280.2 2324.7 2327.6 2012.1 2172.7 2230.1 2265.0 2271.8 2181.4 2210.8 2224.8 2226.8 2250.1 2236.2 2254.4 2257.7 2261.6 2262.1 8381.6 8411.9 8420.6 8470.7 8537.1 4956.5 4996.2 5122.6 5144.6 5163.2 3038.2 3060.3 3168.5 3175.5 3188.6 1048.0 1073.0 1110.7 1122.5 1124.3 11700.0 11703.9 11712.4 11713.5 11791.9 4327.9 4497.1 4617.0 4626.4 4639.1 9738.0 9756.1 9797.1 9797.7 9804.6 5181.4 5187.4 5195.5 5195.7 5196.7 4702.2 4769.2 4771.9 4783.5 4821.6 3752.3 3817.7 3828.7 3907.2 3914.5 1162.6 1221.2 1265.7 1270.4 1283.3 799.4 943.1 947.4 952.8 972.4 5586.2 5638.7 5694.0 5729.5 5734.3 932.5 945.2 950.3 952.9 963.1 3862.3 3863.4 3864.5 3881.3 3914.5 9820.6 10257.4 10269.0 10269.5 10275.9 10162.8 10172.8 10179.8 10186.8 10189.4 7518.7 7698.2 7810.1 7812.9 7892.3 5397.8 5402.8 5493.5 5507.9 5710.5 9433.0 9469.1 9588.0 9656.7 9687.1 9007.8 9395.1 9412.1 9627.8 9722.8 7254.0 7422.2 7427.8 7431.9 7433.0 7944.6 7997.9 8061.1 8128.8 8229.4 5781.6 7074.7 7150.9 7157.8 7332.8 7150.1 7207.9 7228.4 7373.7 7445.0 6735.5 6791.1 6838.4 6840.1 6913.7 4738.8 4797.0 4836.5 4914.7 5071.3 4778.2 4806.3 4838.2 4873.7 4879.9 18:36:16 INFO - PROCESS | 21863 | 18:36:16 INFO - PROCESS | 21863 | [#4] prototype.html Cycles:180 Average:4680.74 Median:5250.16 stddev:1386.73 (26.4%) stddev-sans-first:1351.32 18:36:16 INFO - PROCESS | 21863 | Values: 313.3 325.3 335.8 341.4 341.7 5190.8 5345.7 5355.4 5422.7 5434.9 5186.2 5286.8 5314.9 5318.3 5332.0 4144.5 4153.9 4166.3 4169.4 4183.5 4068.3 4112.2 4171.4 4180.6 4181.3 4124.3 4134.7 4140.0 4146.6 4150.8 4144.1 4146.4 4148.3 4150.5 4161.5 3671.0 3682.6 3684.4 3688.3 3694.8 5070.7 5217.7 5234.7 5248.3 5252.0 4739.9 4741.5 4746.1 4754.5 4785.8 5402.0 5540.9 5574.5 5653.9 5655.5 3977.0 3983.7 3984.4 3990.0 3992.8 5748.8 5770.4 5784.8 5795.7 5818.3 4075.9 4087.2 4088.2 4104.9 4109.1 4055.6 4137.5 4146.2 4151.4 4174.0 4699.8 4699.9 4704.9 4706.3 4730.7 5633.9 5636.4 5637.7 5650.0 5656.6 1330.6 1331.5 1426.2 1431.2 1439.1 894.3 913.4 923.4 924.1 931.5 4856.6 4885.8 4891.2 4897.4 4900.8 5110.6 5111.3 5114.9 5124.8 5125.8 4730.3 4804.4 4831.3 4877.9 5157.2 3047.6 3063.1 3078.4 3080.1 3120.5 5909.6 5915.5 5944.2 5945.1 5961.9 5648.5 5912.0 5928.6 5972.6 5981.0 5988.6 5991.8 5997.8 6027.8 6029.8 5572.8 5786.2 5790.0 5794.4 5846.0 5732.0 5749.0 5755.7 5768.2 5781.4 5945.2 5951.0 5972.8 5982.8 5990.4 3847.4 4001.5 4027.0 4039.2 4053.7 5516.3 5741.7 5757.5 5781.0 5791.8 5533.5 5573.5 5576.7 5588.2 5637.2 5629.6 5650.0 5651.2 5667.2 5684.8 5440.5 5624.3 5646.3 5660.9 5661.6 5623.6 5690.6 5706.9 5721.7 5722.0 5443.3 5573.0 5578.7 5579.7 5588.2 18:36:16 INFO - PROCESS | 21863 | 18:36:16 INFO - PROCESS | 21863 | [#5] yui.html Cycles:180 Average:16571.87 Median:4445.28 stddev:20844.03 (468.9%) stddev-sans-first:20868.21 18:36:16 INFO - PROCESS | 21863 | Values: 649.8 656.3 691.0 695.0 739.8 14564.3 15322.1 15378.0 15522.4 15565.6 14791.4 15578.4 15636.1 15637.8 15640.2 793.2 815.6 818.1 818.3 819.0 653.2 676.1 771.6 792.6 801.1 849.3 849.8 855.8 857.8 858.0 853.4 853.5 853.7 854.2 854.4 497.7 513.7 518.9 519.1 589.8 13761.6 14149.2 14283.4 14363.9 14383.6 13418.7 13656.9 13663.2 13724.6 13800.0 12288.8 12585.3 12826.5 12882.2 12905.0 4390.0 4401.9 4412.2 4428.9 4442.6 53748.5 55463.4 64686.4 64819.4 64969.0 10950.5 10987.7 11070.2 11134.1 11180.0 19647.6 19788.8 19876.7 19888.4 19986.0 7872.5 8087.6 8163.4 8197.4 8338.3 4297.6 4326.2 4372.3 4443.6 4447.0 3464.4 3569.4 3570.3 3572.2 3572.2 590.0 593.7 603.0 608.3 617.8 639.0 693.1 706.9 726.9 770.6 9067.5 9440.3 9472.5 9546.8 9779.0 558.4 607.0 624.2 633.4 712.4 4234.8 4312.9 4337.4 4413.2 4482.6 72372.6 78999.0 80363.6 81812.6 82530.0 45474.1 45613.5 46372.8 46724.0 71461.0 65987.0 66799.7 66899.0 67009.7 67838.7 8261.0 8434.8 8453.9 8473.4 8542.1 43001.6 43231.8 43474.3 44577.3 44913.6 54361.7 58932.4 59131.0 59806.0 61015.7 10721.8 10905.9 10925.5 11723.9 11788.4 13609.3 13833.2 14070.6 14151.7 14512.7 12786.9 12998.6 13246.9 13632.7 13784.2 11405.9 11802.9 11820.6 11987.2 12071.9 11958.3 12111.6 12275.9 12808.0 12930.2 10227.6 10536.5 10584.7 10817.0 11050.2 11301.8 11365.5 11389.2 11442.0 11452.8 18:36:16 INFO - PROCESS | 21863 | -------- Summary: end -------- 18:36:16 INFO - PROCESS | 21863 | 18:36:17 INFO - TEST-INFO | 21863: exit 0 18:36:17 INFO - TEST-OK | dromaeo_css | took 1118641ms 18:36:17 INFO - TEST-START | kraken 18:36:17 INFO - operating with platform_type : linux_ 18:36:17 INFO - Initialising browser for kraken test... 18:36:17 INFO - TEST-INFO | started process 22171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHba6eh/profile http://localhost:42180/getInfo.html) 18:36:21 INFO - PROCESS | 22171 | __metrics Screen width/height:1600/1200 18:36:21 INFO - PROCESS | 22171 | colorDepth:24 18:36:21 INFO - PROCESS | 22171 | Browser inner width/height: 1024/697 18:36:21 INFO - PROCESS | 22171 | __metrics 18:36:22 INFO - PROCESS | 22171 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:36:22 INFO - PROCESS | 22171 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:36:23 INFO - PROCESS | 22171 | console.error: PushService: 18:36:23 INFO - PROCESS | 22171 | stateChangeProcessEnqueue: Error transitioning state 18:36:23 INFO - PROCESS | 22171 | UnknownError 18:36:23 INFO - TEST-INFO | 22171: exit 0 18:36:23 INFO - Browser initialized. 18:36:23 INFO - Running cycle 1/1 for kraken test... 18:36:23 INFO - TEST-INFO | started process 22256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHba6eh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:36:35 INFO - PROCESS | 22256 | RSS: Main: 173867008 18:36:35 INFO - PROCESS | 22256 | 18:36:38 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42180/tests/kraken/driver.html?testName=audio-beat-detection) 18:36:39 INFO - PROCESS | 22256 | RSS: Main: 230588416 18:36:39 INFO - PROCESS | 22256 | 18:36:42 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42180/tests/kraken/driver.html?testName=audio-dft) 18:36:42 INFO - PROCESS | 22256 | RSS: Main: 218267648 18:36:42 INFO - PROCESS | 22256 | 18:36:45 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42180/tests/kraken/driver.html?testName=audio-fft) 18:36:46 INFO - PROCESS | 22256 | RSS: Main: 299638784 18:36:46 INFO - PROCESS | 22256 | 18:36:48 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42180/tests/kraken/driver.html?testName=audio-oscillator) 18:36:49 INFO - PROCESS | 22256 | RSS: Main: 208191488 18:36:49 INFO - PROCESS | 22256 | 18:36:51 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:36:51 INFO - PROCESS | 22256 | RSS: Main: 213843968 18:36:51 INFO - PROCESS | 22256 | 18:36:54 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42180/tests/kraken/driver.html?testName=imaging-darkroom) 18:36:55 INFO - PROCESS | 22256 | RSS: Main: 250032128 18:36:55 INFO - PROCESS | 22256 | 18:36:58 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42180/tests/kraken/driver.html?testName=imaging-desaturate) 18:36:59 INFO - PROCESS | 22256 | RSS: Main: 249044992 18:36:59 INFO - PROCESS | 22256 | 18:37:01 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42180/tests/kraken/driver.html?testName=json-parse-financial) 18:37:02 INFO - PROCESS | 22256 | RSS: Main: 248598528 18:37:02 INFO - PROCESS | 22256 | 18:37:04 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:37:04 INFO - PROCESS | 22256 | RSS: Main: 210931712 18:37:04 INFO - PROCESS | 22256 | 18:37:06 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42180/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:37:07 INFO - PROCESS | 22256 | RSS: Main: 217833472 18:37:07 INFO - PROCESS | 22256 | 18:37:09 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:37:09 INFO - PROCESS | 22256 | RSS: Main: 227389440 18:37:09 INFO - PROCESS | 22256 | 18:37:12 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:37:13 INFO - PROCESS | 22256 | RSS: Main: 236150784 18:37:13 INFO - PROCESS | 22256 | 18:37:15 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:37:16 INFO - PROCESS | 22256 | RSS: Main: 233508864 18:37:16 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | Cycle 1(1): loaded http://localhost:42180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42180/tests/kraken/driver.html?testName=ai-astar) 18:37:18 INFO - PROCESS | 22256 | RSS: Main: 283267072 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | __start_tp_report 18:37:18 INFO - PROCESS | 22256 | _x_x_mozilla_page_load 18:37:18 INFO - PROCESS | 22256 | _x_x_mozilla_page_load_details 18:37:18 INFO - PROCESS | 22256 | |i|pagename|runs| 18:37:18 INFO - PROCESS | 22256 | |0;ai-astar;104;111;111;111;112;113;111;110;112;111 18:37:18 INFO - PROCESS | 22256 | |1;audio-beat-detection;158;121;126;168;125;124;135;129;160;127 18:37:18 INFO - PROCESS | 22256 | |2;audio-dft;160;160;160;161;162;160;160;161;160;160 18:37:18 INFO - PROCESS | 22256 | |3;audio-fft;75;75;76;102;75;75;84;76;100;74 18:37:18 INFO - PROCESS | 22256 | |4;audio-oscillator;82;84;112;89;82;83;107;82;82;125 18:37:18 INFO - PROCESS | 22256 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;117;117 18:37:18 INFO - PROCESS | 22256 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;146 18:37:18 INFO - PROCESS | 22256 | |7;imaging-desaturate;84;85;86;84;85;85;84;84;84;84 18:37:18 INFO - PROCESS | 22256 | |8;json-parse-financial;57;54;55;55;56;58;58;56;57;56 18:37:18 INFO - PROCESS | 22256 | |9;json-stringify-tinderbox;61;61;61;61;61;60;60;62;61;61 18:37:18 INFO - PROCESS | 22256 | |10;stanford-crypto-aes;80;80;81;80;84;87;82;79;80;80 18:37:18 INFO - PROCESS | 22256 | |11;stanford-crypto-ccm;140;134;131;133;138;133;131;128;165;135 18:37:18 INFO - PROCESS | 22256 | |12;stanford-crypto-pbkdf2;162;165;164;164;165;163;163;163;165;173 18:37:18 INFO - PROCESS | 22256 | |13;stanford-crypto-sha256-iterative;67;67;68;64;65;65;64;65;65;62 18:37:18 INFO - PROCESS | 22256 | __end_tp_report 18:37:18 INFO - PROCESS | 22256 | __start_cc_report 18:37:18 INFO - PROCESS | 22256 | _x_x_mozilla_cycle_collect,1715 18:37:18 INFO - PROCESS | 22256 | __end_cc_report 18:37:18 INFO - PROCESS | 22256 | __startTimestamp1477964238330__endTimestamp 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | ------- Summary: start ------- 18:37:18 INFO - PROCESS | 22256 | Number of tests: 14 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.46 (2.2%) stddev-sans-first:0.87 18:37:18 INFO - PROCESS | 22256 | Values: 104.0 111.0 111.0 111.0 112.0 113.0 111.0 110.0 112.0 111.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:132.00 stddev:17.60 (13.3%) stddev-sans-first:17.00 18:37:18 INFO - PROCESS | 22256 | Values: 158.0 121.0 126.0 168.0 125.0 124.0 135.0 129.0 160.0 127.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 18:37:18 INFO - PROCESS | 22256 | Values: 160.0 160.0 160.0 161.0 162.0 160.0 160.0 161.0 160.0 160.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:10.82 (14.4%) stddev-sans-first:11.24 18:37:18 INFO - PROCESS | 22256 | Values: 75.0 75.0 76.0 102.0 75.0 75.0 84.0 76.0 100.0 74.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:82.00 stddev:15.85 (19.3%) stddev-sans-first:16.32 18:37:18 INFO - PROCESS | 22256 | Values: 82.0 84.0 112.0 89.0 82.0 83.0 107.0 82.0 82.0 125.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:37:18 INFO - PROCESS | 22256 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 18:37:18 INFO - PROCESS | 22256 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 18:37:18 INFO - PROCESS | 22256 | Values: 84.0 85.0 86.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.32 (2.3%) stddev-sans-first:1.36 18:37:18 INFO - PROCESS | 22256 | Values: 57.0 54.0 55.0 55.0 56.0 58.0 58.0 56.0 57.0 56.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 18:37:18 INFO - PROCESS | 22256 | Values: 61.0 61.0 61.0 61.0 61.0 60.0 60.0 62.0 61.0 61.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.50 stddev:2.45 (3.0%) stddev-sans-first:2.55 18:37:18 INFO - PROCESS | 22256 | Values: 80.0 80.0 81.0 80.0 84.0 87.0 82.0 79.0 80.0 80.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:134.50 stddev:10.50 (7.8%) stddev-sans-first:11.07 18:37:18 INFO - PROCESS | 22256 | Values: 140.0 134.0 131.0 133.0 138.0 133.0 131.0 128.0 165.0 135.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:164.50 stddev:3.09 (1.9%) stddev-sans-first:3.12 18:37:18 INFO - PROCESS | 22256 | Values: 162.0 165.0 164.0 164.0 165.0 163.0 163.0 163.0 165.0 173.0 18:37:18 INFO - PROCESS | 22256 | 18:37:18 INFO - PROCESS | 22256 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.75 (2.7%) stddev-sans-first:1.73 18:37:18 INFO - PROCESS | 22256 | Values: 67.0 67.0 68.0 64.0 65.0 65.0 64.0 65.0 65.0 62.0 18:37:18 INFO - PROCESS | 22256 | -------- Summary: end -------- 18:37:18 INFO - PROCESS | 22256 | 18:37:19 INFO - TEST-INFO | 22256: exit 0 18:37:19 INFO - TEST-OK | kraken | took 62041ms 18:37:19 INFO - SUITE-END | took 1180s 18:37:19 INFO - Completed test suite (00:19:41) 18:37:19 INFO - javascript benchmark 18:37:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.388322335533, 3084.3831233753253, 3099.333643266698, 3128.1866714654184, 3148.6379066407358, 5299.8410047698535, 5385.865353366168, 5403.2165336026355, 5456.481634244746, 5472.425395333487, 5386.8922621547545, 5393.514583687467, 5394.271773310602, 5399.1091469907415, 5466.043442397585, 4887.584555312794, 4915.0, 4947.802087916497, 4971.850844474671, 4991.201407774757, 4954.7522623868845, 4975.27858460523, 5011.874703132415, 5012.949870501285, 5023.171176755849, 5079.822206222783, 5089.134847076006, 5104.974475127638, 5145.253938178962, 5145.382554093514, 5085.23721441783, 5089.491050894918, 5089.7455127243675, 5091.567216786578, 5148.150555158394, 4823.324734537167, 4925.458199598042, 5027.421846487664, 5033.546980771748, 5034.395872495324, 5433.483819037185, 5452.836414907559, 5458.645188062763, 5466.207399926989, 5532.3637781655225, 5939.109133629947, 5948.553858460589, 5950.553708471839, 5950.9883319835735, 5953.226080609536, 5687.60186786921, 5738.139279108125, 5808.59339846211, 5870.324912635059, 5963.344032156459, 5449.855530338594, 5466.125419932791, 5470.781168753285, 5473.042217611902, 5511.200875872976, 5986.341502434729, 5993.130996005555, 5995.490383317379, 5997.220361353084, 5999.5800293979, 5552.333719953632, 5618.4662457066515, 5619.971900140473, 5669.092945128759, 5758.424157584292, 5827.096799996008, 5857.677827719516, 5864.266966629171, 5911.822645320647, 5933.080372542263, 5799.33307669615, 5834.504067154255, 5844.1818145459665, 5845.649261044351, 5853.268341457318, 5664.461876121844, 5730.398308177665, 5798.478136967693, 5861.853453663607, 5907.025340818716, 4425.690201685851, 4450.287953927421, 4455.7994890229365, 4461.776911154429, 4532.070925460339, 3980.20395920817, 3989.202159568098, 3994.121293315466, 4028.1742242840146, 4031.899202519902, 5586.91619625706, 5595.328560572757, 5603.2435621191435, 5661.773529058792, 5665.433456654301, 5625.353084395347, 5743.741531631086, 5748.080307150836, 5931.703414829241, 5936.5250779937505, 5458.590605704509, 5517.282753242133, 5540.63985840919, 5622.493975542221, 5624.409437009055, 4993.775280112403, 5030.547250747451, 5041.420236672756, 5047.192449208109, 5105.821296254613, 6041.909371359433, 6058.363871793486, 6071.787487438007, 6075.149479073022, 6076.3012253591405, 5647.3787883333625, 5720.6853623049465, 5836.095405212199, 5876.588638795243, 5900.498457631149, 6091.692560820238, 6095.317435523607, 6112.199536562638, 6118.223266370627, 6121.615429060945, 5808.7095645218415, 5821.476067153976, 5823.417658234142, 5823.475887170175, 5883.499902508334, 5686.09022556389, 5758.395368486416, 5775.931452681268, 5873.530117590668, 5927.881442371215, 5647.802326918538, 5688.971555142198, 5718.428157184248, 5720.3707592165665, 5761.769529218785, 5692.772289108555, 5700.173474846041, 5700.429957004267, 5702.315722113207, 5707.914381284201, 5552.278203833475, 5561.110222364564, 5684.431556844283, 5692.430756924275, 5694.743736531783, 5734.684592347461, 5774.653520788598, 5797.449242321973, 5821.94178058231, 5886.558508111823, 5678.4605462480995, 5688.14677798317, 5697.914531282117, 5699.971500142473, 5700.914486282626], "value": 5397.357819323881, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.1345603756092, 582.8513728999104, 607.5898768331376, 610.6031079798131, 639.0127253393507, 31882.0, 34934.0, 43316.99999999996, 44025.59744025596, 44037.33943990843, 44063.0, 44498.77750611243, 44516.77741611296, 44549.7772511137, 44556.77721611387, 8854.645814167425, 9009.549522523848, 9021.819563608724, 9024.23294020009, 9024.413413128159, 7986.560739159344, 8183.222593853575, 8190.631421586043, 8393.916060839405, 8822.911770882272, 10551.894481055167, 10790.190735694816, 10791.62229321974, 11218.102551795877, 11232.326060436359, 10805.459727013656, 10875.782484350348, 10879.401632910227, 10882.945585272102, 10883.292585981886, 10539.683809485728, 10727.0, 10735.355878647306, 10747.731306717316, 10749.355038697704, 42218.36672449916, 42475.787621061696, 42476.78761606172, 42593.57406425958, 42707.57292427067, 3519.243362677011, 3539.0, 3651.790666646667, 3866.5360156781367, 4039.5354534228354, 30461.847690761628, 30624.693753062405, 30745.231369215726, 30802.0, 30986.690133098833, 4346.261135606923, 4395.868123956287, 4402.955970440319, 4446.377507149002, 4475.977620111911, 356243.0, 356622.2168889165, 357304.05611466867, 358556.0, 359533.0, 58031.38858751366, 58285.708571456875, 58552.0, 58592.70703646455, 58615.70692146512, 31610.36779264448, 32115.03654890357, 32184.19539511531, 32270.0, 62721.68639156775, 13919.860801392058, 13956.09285396446, 14017.229052402012, 14018.228997405036, 14022.0, 11354.886451135382, 11532.616086069725, 11536.0, 11550.653480395602, 11632.069434445224, 16388.44309790568, 16719.414820481226, 18235.0, 18791.812081879005, 19124.505741150817, 6919.411849992807, 7055.89416158758, 7058.188308344504, 7181.281871812881, 7196.712131514785, 929.3355250995571, 990.1385794358954, 1032.3031953431405, 1050.558765318568, 1081.551156270139, 31087.0, 31221.0, 31292.53061204084, 31365.843170784457, 32005.35989280248, 1048.9685309440729, 1075.5160177919968, 1092.819684752023, 1115.827046807746, 1118.4854966715238, 15930.522084337488, 16614.83385166133, 16758.0, 16781.664366712597, 16785.160741962853, 570063.0, 577058.0, 578372.0, 578455.0, 580386.0, 48726.26910596344, 48875.26687099625, 53294.73352633212, 54048.729756350964, 54155.72922135443, 1285.4022879361141, 1306.7125232448846, 1310.8361454818148, 1323.358171286925, 1331.8202042724301, 30079.26076393041, 32306.0, 32375.0, 32444.35111297808, 32710.0, 49498.50501494939, 50062.0, 50079.74960125176, 50152.0, 51931.74034129805, 369904.0, 529384.0, 530672.0, 531156.0, 532444.0, 40597.39103913503, 40687.38968915528, 40872.0, 41217.58782412137, 41728.16543669171, 45121.0, 45851.77074114608, 45857.541424585324, 49173.0, 50055.0, 37843.62156378511, 41866.790666047695, 41925.1614967705, 42026.159476810906, 43841.12317753691, 42001.57998420099, 42104.3684344729, 42256.1548769029, 42721.572784273005, 43325.56674433215, 40958.38562421626, 41716.374254386814, 43102.35346469743, 43190.35214471848, 43312.566874332115, 34828.477572835924, 37113.257734844614, 37682.767167371385, 38095.809520952214, 38309.4253586202, 28415.715842842135, 28965.85517072401, 29043.0, 29097.85451072731, 29098.0], "value": 20208.16766779032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.20934049760785, 378.4984895014107, 389.54423324710086, 390.1475276520802, 411.5945793393507, 14266.286685665727, 18055.4583362499, 18469.0, 18502.62994740106, 19815.5046123847, 18487.537811554717, 19135.904320478414, 19301.420957371265, 19306.0, 19351.709724354147, 5487.890242195153, 5738.856528586798, 5753.367129615739, 5757.942420575782, 5758.712064396764, 4064.817083231247, 4272.9359059614135, 4334.934975975347, 5591.329040515144, 5705.0, 6296.0, 6411.006294024411, 6421.550491465576, 6425.22897252328, 6425.935740642581, 6161.229846269216, 6236.126942228115, 6281.057841323793, 6290.182276304097, 6418.165638466993, 5571.164325351189, 5574.665520068809, 5575.0, 5578.30271216098, 5581.748821303051, 23105.88447057771, 23164.073437062496, 23271.53456930869, 23279.534409311887, 23430.17994370189, 2434.1358817619844, 2623.3966187776728, 2742.287005378596, 2753.0, 2813.9296517587018, 13805.654858628513, 14181.78727319091, 14235.644108897257, 14525.636859078502, 14783.408663653441, 1868.252698920429, 1888.1031510032624, 1926.1332400419867, 1930.4691209917244, 1959.6472634925708, 71734.1644822581, 73073.26926730771, 73592.26407735908, 82337.58831205805, 83832.58083709542, 10638.734031649115, 10739.83890241647, 10947.233693641369, 11201.818335210897, 11219.719507012227, 15551.611209719622, 15585.454509092355, 15616.687666246611, 15636.296366663528, 15638.687226255412, 7392.519486233377, 7639.770806875691, 7678.923210767933, 7798.064232292161, 7811.101723301779, 7080.221175670672, 7106.71573137079, 7107.609081500464, 7340.082489688789, 7397.482176247719, 4645.9303110453375, 4706.0, 4745.406824146981, 4782.808687652525, 4829.9034019319415, 1808.5478630342413, 1860.144333606529, 1942.2619404626153, 1967.2917749610128, 2004.2383894120433, 816.5508970066439, 833.2001278772325, 845.7547311279783, 942.4627962061559, 958.4584709639032, 18568.535786605175, 18844.905775471034, 19645.901770491055, 19762.50593735168, 19845.503862403555, 894.3113802372137, 915.0, 959.3811991265594, 971.4511301114989, 984.4339504784634, 8856.734297971072, 10724.356538607708, 10873.2059210231, 10896.673099807018, 10974.670759877217, 469207.0, 475601.0, 482779.0, 490748.0, 490806.0, 91699.0, 92797.53601231951, 93197.5340123295, 93745.5312723432, 95286.09427811405, 954.3224310739314, 978.1636700621009, 1015.9898401015895, 1016.420640235059, 1021.1626466297713, 16721.665566688356, 16946.237419315912, 17594.29622815124, 18033.72949405786, 18197.45407637773, 39356.80321598374, 43524.0, 43632.0, 43666.78166609147, 44622.77688611666, 57744.71127644335, 59122.0, 60644.0, 61401.38598614135, 61784.38215617966, 8125.634346454305, 8450.915490845013, 8469.237768600855, 8508.0, 8788.868166977372, 9766.023397660178, 11762.882371176178, 13142.934285328512, 13215.537456189371, 13716.65708357299, 11723.179377443497, 11764.82352764692, 11856.0, 12062.577809776616, 12092.879071209176, 11318.434078296217, 11478.139139564399, 11584.478698458759, 11639.941800290944, 11694.166396245793, 10865.619703310345, 11924.701882453008, 12007.519699211934, 12019.338936358585, 12062.155649104478, 7372.96313518429, 7517.248275172439, 7522.097348318237, 8113.310368618733, 8701.17338852808, 11573.0, 11687.88312116868, 11794.646160615195, 11823.645290641294, 12364.56724014655], "value": 9194.27770501703, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.6453386653334, 1469.331454188344, 1568.9912274139576, 1723.6121872578678, 1731.4978656189714, 7369.336759691627, 7604.391648668107, 8003.199680031994, 8506.0, 8528.488290702555, 7881.251281128284, 8261.83476330473, 8283.213094755989, 8510.148985101487, 8510.872336914952, 2265.592193405186, 2275.055851821492, 2284.246198754415, 2285.2116019973164, 2289.919852805152, 2014.1943222710959, 2227.7438094619083, 2280.1905323610126, 2324.6861673674007, 2327.569399661068, 2012.0845015517978, 2172.6849606807004, 2230.096810791632, 2265.0486795545826, 2271.761465046163, 2181.4219231903558, 2210.7568167501563, 2224.810891074261, 2226.821854251672, 2250.144944920936, 2236.2396785092983, 2254.3800454874877, 2257.7177852768405, 2261.5929132756096, 2262.061244583496, 8381.622826972802, 8411.915880841174, 8420.578971051424, 8470.703525376583, 8537.10360412154, 4956.536900047331, 4996.200607902718, 5122.641415100945, 5144.61415393847, 5163.199704045879, 3038.179691483287, 3060.296131889678, 3168.5088811234295, 3175.4601717707815, 3188.6333071696818, 1047.9685609431729, 1073.0, 1110.6667999600088, 1122.5004872831594, 1124.2973141786383, 11700.0, 11703.94148029263, 11712.355820429873, 11713.53145874164, 11791.882081179165, 4327.891802704895, 4497.145542346943, 4617.0, 4626.398568186114, 4639.118567472169, 9737.9775123611, 9756.07317304855, 9797.118259356692, 9797.657082002095, 9804.558794854249, 5181.4041385240425, 5187.377514698185, 5195.532402083755, 5195.7142357170715, 5196.740162991835, 4702.224133018014, 4769.165396055676, 4771.904561908743, 4783.521647835259, 4821.614270858393, 3752.305823422621, 3817.7136714746507, 3828.674562662205, 3907.238088572701, 3914.549826769901, 1162.604714397109, 1221.2428294457493, 1265.6772523006575, 1270.4346565778326, 1283.3006011723633, 799.444386151619, 943.094629156018, 947.3652652722692, 952.8237276103943, 972.3776782858976, 5586.24585680936, 5638.746256418471, 5694.032014557535, 5729.512991395694, 5734.340550836707, 932.4778124250441, 945.177695405002, 950.292032435826, 952.8523078922778, 963.1043129889131, 3862.3240932837202, 3863.3818589025623, 3864.4976153099915, 3881.262560113569, 3914.5106861642294, 9820.607175712892, 10257.435841028666, 10269.0, 10269.537870795832, 10275.897241027644, 10162.796744065077, 10172.796544069077, 10179.84730229047, 10186.796264074825, 10189.439580823126, 7518.736844210426, 7698.153203147649, 7810.10183828867, 7812.921870781333, 7892.329152022143, 5397.78408863641, 5402.783888644411, 5493.505584497414, 5507.917381239365, 5710.5146062585145, 9433.0, 9469.14777670013, 9587.952060239653, 9656.71029869105, 9687.079727425884, 9007.77480562965, 9395.107464791108, 9412.058794120534, 9627.759306017126, 9722.805543889224, 7253.963730181315, 7422.183559808309, 7427.8143046424275, 7431.925680743123, 7433.0, 7944.6424910877995, 7997.880031799411, 8061.113277539349, 8128.75613731589, 8229.382796290183, 5781.624194427349, 7074.68163932614, 7150.856982860209, 7157.785266442015, 7332.78001659951, 7150.070490836158, 7207.891881621885, 7228.421726261991, 7373.668184931584, 7444.962775186089, 6735.528513004043, 6791.117154769849, 6838.350356716104, 6840.076589660531, 6913.654317284015, 4738.8341408050555, 4796.9760151199025, 4836.540528649773, 4914.655974081923, 5071.264666623393, 4778.163821331323, 4806.327114204084, 4838.2016967201425, 4873.707577545359, 4879.853604391874], "value": 4436.422310333434, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.2575795364984, 325.342807528792, 335.8387973772589, 341.3667646515713, 341.6839423533231, 5190.754218987444, 5345.705986170759, 5355.437679043698, 5422.674639521627, 5434.864128396787, 5186.196139598368, 5286.814961476349, 5314.92027619586, 5318.27156174243, 5331.960267747791, 4144.52337981133, 4153.854615088472, 4166.333386658128, 4169.374593810938, 4183.5398106208295, 4068.328725760246, 4112.198121366335, 4171.435711608147, 4180.6237438630515, 4181.268278051329, 4124.298869192229, 4134.710570260083, 4139.979300103495, 4146.647534959532, 4150.792460376984, 4144.129732756125, 4146.3780432935, 4148.274052040881, 4150.481189851269, 4161.459010328638, 3670.9632903671154, 3682.6317368263226, 3684.3552378333684, 3688.2807852468777, 3694.7598406103516, 5070.6957582545165, 5217.660852044605, 5234.659747116425, 5248.343957005374, 5251.973740131313, 4739.928901066487, 4741.502142275081, 4746.050789842046, 4754.453237877654, 4785.760711964423, 5401.972990135024, 5540.889182216373, 5574.526165275956, 5653.886922261532, 5655.519280861091, 3977.0, 3983.665472066861, 3984.3625019996953, 3989.98005009976, 3992.820323085439, 5748.770049198027, 5770.365259821417, 5784.826455206308, 5795.710214489301, 5818.3308919474375, 4075.8573449929704, 4087.2234275487563, 4088.2232375848494, 4104.8768536943935, 4109.116539943926, 4055.5741647127215, 4137.482814648169, 4146.170765846843, 4151.418801367811, 4174.036434131801, 4699.765011749399, 4699.85900422981, 4704.882377940579, 4706.270528068155, 4730.716157030589, 5633.887322253532, 5636.408177141423, 5637.746301416446, 5649.971750141223, 5656.60403771732, 1330.6141219046563, 1331.460758392833, 1426.179946530749, 1431.2128329418986, 1439.0502268502737, 894.2622336572354, 913.4336711238941, 923.422860712055, 924.1405492891676, 931.4504442379028, 4856.562909338177, 4885.828995985124, 4891.190259603969, 4897.363342765418, 4900.779464924087, 5110.572478072886, 5111.309973153651, 5114.872128196825, 5124.769385377593, 5125.846684496033, 4730.290456431563, 4804.42346918372, 4831.275308703653, 4877.9024419512125, 5157.200633901752, 3047.649520305149, 3063.1423201503617, 3078.3535457553717, 3080.1375614827884, 3120.485119955227, 5909.6158749681135, 5915.526757859361, 5944.197533332945, 5945.078512830518, 5961.880762384815, 5648.548116150698, 5912.0144327115395, 5928.644281343133, 5972.552058595623, 5980.970095149496, 5988.640681559121, 5991.820245392558, 5997.790077347272, 6027.819165425044, 6029.784236635366, 5572.777088916398, 5786.161006654096, 5790.0, 5794.391588883106, 5846.0, 5731.971340143273, 5749.0, 5755.7122143893475, 5768.221290125947, 5781.364049954585, 5945.197398351167, 5950.9702451487465, 5972.790952316648, 5982.760689572368, 5990.400959903975, 3847.3651847444858, 4001.459802926684, 4027.033511957168, 4039.212353591139, 4053.6757059435763, 5516.310461192351, 5741.74162162712, 5757.5393968481585, 5780.971095144498, 5791.797287094932, 5533.529649979797, 5573.498385145356, 5576.749046293007, 5588.239704493071, 5637.154426836008, 5629.577781666309, 5650.0, 5651.208830763779, 5667.206591077335, 5684.77260909559, 5440.510354068153, 5624.268845050281, 5646.265985421869, 5660.886782264414, 5661.575381846295, 5623.578231632726, 5690.630109042899, 5706.8573285666525, 5721.656700597978, 5721.971390143022, 5443.265159203457, 5573.0, 5578.736439183123, 5579.6652200868075, 5588.217649528988], "value": 4236.298414643407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.8148027812075, 656.3141517114615, 690.9877030150828, 694.992261221229, 739.8076500109971, 14564.271786410676, 15322.080675159497, 15377.999999999985, 15522.379104835793, 15565.610859728498, 14791.40834366624, 15578.376864925389, 15636.061836289831, 15637.765433518507, 15640.217989100556, 793.2186796005944, 815.5881279953616, 818.1327792539897, 818.30444122496, 818.950862948222, 653.2128784814288, 676.0872821690728, 771.5910567399287, 792.5957761541626, 801.1107670485757, 849.2611428057598, 849.8470275350435, 855.7903313688155, 857.781265777229, 858.0261403307229, 853.4495250563414, 853.4708480741917, 853.6500034985626, 854.1586537260794, 854.4403415762686, 497.72002503501733, 513.6686836990158, 518.9014087323434, 519.1175002495772, 589.8083122985047, 13761.587152385344, 14149.151050936976, 14283.357248923823, 14363.856361436356, 14383.568492945229, 13418.664533386645, 13656.863431365658, 13663.248521331323, 13724.588262352045, 13800.0, 12288.754224915541, 12585.307808070553, 12826.486940522462, 12882.227066375954, 12905.03212259075, 4389.978050109729, 4401.867943961686, 4412.227860124465, 4428.911421771547, 4442.600165985077, 53748.46251537474, 55463.445365546235, 64686.353136468504, 64819.351806481805, 64969.0, 10950.507227174796, 10987.670369888916, 11070.239796887416, 11134.10927125828, 11180.0, 19647.607047858965, 19788.802111978985, 19876.70184947227, 19888.403347899588, 19986.0, 7872.488288261245, 8087.5551844647935, 8163.38774591908, 8197.385196110195, 8338.291245244101, 4297.613214810682, 4326.199653064194, 4372.278574035312, 4443.555644435531, 4447.0, 3464.4456886897974, 3569.39320315547, 3570.2680950405106, 3572.1962558424148, 3572.2498275361945, 589.9911501327483, 593.6794131169206, 602.9643270858649, 608.2761513798565, 617.8393617659351, 639.0251889043772, 693.1197379328225, 706.9328413800681, 726.9164046134656, 770.6146926536732, 9067.455952642862, 9440.306279321088, 9472.526373681289, 9546.761330966781, 9778.951105244429, 558.4443478738681, 607.0378450156551, 624.1916717850395, 633.4330773957374, 712.3624356201171, 4234.7670878102, 4312.870613881589, 4337.414449049338, 4413.205622987893, 4482.618977386894, 72372.63813680898, 78999.0, 80363.59818200872, 81812.59093704494, 82530.0, 45474.09051818945, 45613.543864561594, 46372.7681361591, 46724.0, 71461.0, 65987.0, 66799.66600166968, 66899.0, 67009.66495167493, 67838.66080669565, 8261.0, 8434.789130271793, 8453.873191902003, 8473.406861519634, 8542.103079176597, 43001.56998430101, 43231.78384108059, 43474.34788478112, 44577.33134003057, 44913.550864490935, 54361.72819135879, 58932.410675892694, 59131.0, 59806.0, 61015.69492152511, 10721.785564288826, 10905.945470272598, 10925.46005586035, 11723.941380293043, 11788.351640659846, 13609.251491168081, 13833.170009799444, 14070.648233794236, 14151.716965660835, 14512.709745805236, 12786.936065319614, 12998.610041698765, 13246.933765331112, 13632.727345453233, 13784.172949623055, 11405.942970285096, 11802.940985295361, 11820.645380638594, 11987.22083064598, 12071.939640302093, 11958.282503049844, 12111.576094836639, 12275.877241227474, 12808.0, 12930.224186548838, 10227.590896364061, 10536.473176341306, 10584.682459526226, 10817.0, 11050.171237157085, 11301.773964520828, 11365.54537818478, 11389.202755807346, 11442.0, 11452.770944581229], "value": 6910.32370380764, "unit": "score"}], "name": "dromaeo_css", "value": 7119.754264920801, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 111.0, 112.0, 113.0, 111.0, 110.0, 112.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 121.0, 126.0, 168.0, 125.0, 124.0, 135.0, 129.0, 160.0, 127.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 162.0, 160.0, 160.0, 161.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 102.0, 75.0, 75.0, 84.0, 76.0, 100.0, 74.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 112.0, 89.0, 82.0, 83.0, 107.0, 82.0, 82.0, 125.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 55.0, 56.0, 58.0, 58.0, 56.0, 57.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 62.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 80.0, 84.0, 87.0, 82.0, 79.0, 80.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 131.0, 133.0, 138.0, 133.0, 131.0, 128.0, 165.0, 135.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 164.0, 164.0, 165.0, 163.0, 163.0, 163.0, 165.0, 173.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 62.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1493.8, "alertThreshold": 2.0}]} 18:37:20 INFO - Return code: 0 18:37:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:37:20 INFO - # TBPL SUCCESS # 18:37:20 INFO - Running post-action listener: _resource_record_post_action 18:37:20 INFO - [mozharness: 2016-11-01 01:37:20.158567Z] Finished run-tests step (success) 18:37:20 INFO - Running post-run listener: _resource_record_post_run 18:37:20 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393097216; Read time: 448; Write time: 563208 18:37:20 INFO - TinderboxPrint: CPU usage
13.1% 18:37:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 448 18:37:20 INFO - TinderboxPrint: I/O write bytes / time
393,097,216 / 563,208 18:37:20 INFO - TinderboxPrint: CPU idle
8,305.1 (86.9%) 18:37:20 INFO - TinderboxPrint: CPU user
1,198.9 (12.5%) 18:37:20 INFO - TinderboxPrint: Swap in / out
0 / 0 18:37:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104087552; Read time: 0; Write time: 159364 18:37:20 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289009664; Read time: 448; Write time: 403844 18:37:20 INFO - Running post-run listener: _upload_blobber_files 18:37:20 INFO - Blob upload gear active. 18:37:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:37:20 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 18:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:37:21 INFO - (blobuploader) - INFO - Open directory for files ... 18:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:37:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:22 INFO - (blobuploader) - INFO - Done attempting. 18:37:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:26 INFO - (blobuploader) - INFO - Done attempting. 18:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:27 INFO - (blobuploader) - INFO - Done attempting. 18:37:27 INFO - (blobuploader) - INFO - Iteration through files over. 18:37:27 INFO - Return code: 0 18:37:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:37:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:37:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13375a14c861512508519e0d5c285613ea04c873ced14efb3fe971c56c10fd5e15ca86b0737a0cb95b280a98e3873c99e24d78ce9543e3e884ca82dd1b93dd27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932e0f051673dd1e000f347ac0502ba8d95b2de0c0e5d6ed20cb203a2e692d2fdc492cfb3f4c9e0d6af7219b028e12a8ed03c9b33dcdc1a776feb0a1bdc12767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8b4cbb9e63eecffd46bf0aacfb7c39bc1e50177bdf9166fd9afeb15d3309bc6aa83d8941aee126f234ebaa175334ec551fc6fe13dcca6f6ca77aa735a0d0824"} 18:37:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:37:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:37:27 INFO - Contents: 18:37:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13375a14c861512508519e0d5c285613ea04c873ced14efb3fe971c56c10fd5e15ca86b0737a0cb95b280a98e3873c99e24d78ce9543e3e884ca82dd1b93dd27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932e0f051673dd1e000f347ac0502ba8d95b2de0c0e5d6ed20cb203a2e692d2fdc492cfb3f4c9e0d6af7219b028e12a8ed03c9b33dcdc1a776feb0a1bdc12767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8b4cbb9e63eecffd46bf0aacfb7c39bc1e50177bdf9166fd9afeb15d3309bc6aa83d8941aee126f234ebaa175334ec551fc6fe13dcca6f6ca77aa735a0d0824"} 18:37:27 INFO - Running post-run listener: copy_logs_to_upload_dir 18:37:27 INFO - Copying logs to upload dir... 18:37:27 INFO - mkdir: /builds/slave/test/build/upload/logs 18:37:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.729194 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-31 18:37:27.154514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 18:37:27.157824) ========= 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=8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13375a14c861512508519e0d5c285613ea04c873ced14efb3fe971c56c10fd5e15ca86b0737a0cb95b280a98e3873c99e24d78ce9543e3e884ca82dd1b93dd27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932e0f051673dd1e000f347ac0502ba8d95b2de0c0e5d6ed20cb203a2e692d2fdc492cfb3f4c9e0d6af7219b028e12a8ed03c9b33dcdc1a776feb0a1bdc12767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8b4cbb9e63eecffd46bf0aacfb7c39bc1e50177bdf9166fd9afeb15d3309bc6aa83d8941aee126f234ebaa175334ec551fc6fe13dcca6f6ca77aa735a0d0824"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477855804/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13375a14c861512508519e0d5c285613ea04c873ced14efb3fe971c56c10fd5e15ca86b0737a0cb95b280a98e3873c99e24d78ce9543e3e884ca82dd1b93dd27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932e0f051673dd1e000f347ac0502ba8d95b2de0c0e5d6ed20cb203a2e692d2fdc492cfb3f4c9e0d6af7219b028e12a8ed03c9b33dcdc1a776feb0a1bdc12767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8b4cbb9e63eecffd46bf0aacfb7c39bc1e50177bdf9166fd9afeb15d3309bc6aa83d8941aee126f234ebaa175334ec551fc6fe13dcca6f6ca77aa735a0d0824"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 18:37:27.184572) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 18:37:27.185005) ========= 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=8783db0840cc980e80bb0bd400000236-1477963005.49902-2129701968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 18:37:27.270218) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 18:37:27.270707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 18:37:27.271101) ========= ========= Total master_lag: 0.18 =========