builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1477468845.23 results: success (0) buildid: 20161026005405 builduid: f6f42133af3d4a27a1bc55714ff42051 revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:45.232385) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:45.232850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:45.233153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:45.248063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:45.248491) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 01:00: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-26 01:00:45 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083987 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:45.348657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:45.349279) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019519 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:45.402505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 01:00:45.403178) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --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 b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --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=934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 01:00:45,517 truncating revision to first 12 chars 2016-10-26 01:00:45,517 Setting DEBUG logging. 2016-10-26 01:00:45,517 attempt 1/10 2016-10-26 01:00:45,517 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b1b18f25c0ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 01:00:46,408 unpacking tar archive at: fx-team-b1b18f25c0ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.205824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 01:00:46.626606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:46.627250) ========= script_repo_revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:46.628009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:46.628532) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 01:00:46.641447) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-26 01:00:46.642027) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:00:46 INFO - MultiFileLogger online at 20161026 01:00:46 in /builds/slave/test 01:00: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 01:00:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:00:46 INFO - {'append_to_log': False, 01:00:46 INFO - 'base_work_dir': '/builds/slave/test', 01:00:46 INFO - 'blob_upload_branch': 'Fx-Team', 01:00:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:00:46 INFO - 'branch': 'Fx-Team', 01:00:46 INFO - 'buildbot_json_path': 'buildprops.json', 01:00:46 INFO - 'config_files': ('talos/linux_config.py',), 01:00:46 INFO - 'default_actions': ('clobber', 01:00:46 INFO - 'read-buildbot-config', 01:00:46 INFO - 'download-and-extract', 01:00:46 INFO - 'populate-webroot', 01:00:46 INFO - 'create-virtualenv', 01:00:46 INFO - 'install', 01:00:46 INFO - 'run-tests'), 01:00:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:00:46 INFO - 'download_minidump_stackwalk': True, 01:00:46 INFO - 'download_symbols': 'ondemand', 01:00:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:00:46 INFO - 'tooltool.py': '/tools/tooltool.py', 01:00:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:00:46 INFO - '/tools/misc-python/virtualenv.py')}, 01:00:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:00:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:00:46 INFO - 'installer_path': 'installer.exe', 01:00:46 INFO - 'log_level': 'info', 01:00:46 INFO - 'log_name': 'talos', 01:00:46 INFO - 'log_to_console': True, 01:00:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:00:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:00:46 INFO - 'opt_config_files': (), 01:00:46 INFO - 'pip_index': False, 01:00:46 INFO - 'sps_profile': False, 01:00:46 INFO - 'sps_profile_interval': 0, 01:00:46 INFO - 'suite': 'dromaeojs', 01:00:46 INFO - 'system_bits': '32', 01:00:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:00:46 INFO - 'title': 'talos-linux64-ix-057', 01:00:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:00:46 INFO - 'use_talos_json': True, 01:00:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:00:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:00:46 INFO - 'work_dir': 'build'} 01:00:46 INFO - [mozharness: 2016-10-26 08:00:46.866581Z] Running clobber step. 01:00:46 INFO - Running pre-action listener: _resource_record_pre_action 01:00:46 INFO - Running main action method: clobber 01:00:46 INFO - rmtree: /builds/slave/test/build 01:00:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:00:47 INFO - Running post-action listener: _resource_record_post_action 01:00:47 INFO - [mozharness: 2016-10-26 08:00:47.831323Z] Finished clobber step (success) 01:00:47 INFO - [mozharness: 2016-10-26 08:00:47.831423Z] Running read-buildbot-config step. 01:00:47 INFO - Running pre-action listener: _resource_record_pre_action 01:00:47 INFO - Running main action method: read_buildbot_config 01:00:47 INFO - Using buildbot properties: 01:00:47 INFO - { 01:00:47 INFO - "project": "", 01:00:47 INFO - "product": "firefox", 01:00:47 INFO - "script_repo_revision": "production", 01:00:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:00:47 INFO - "repository": "", 01:00:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:00:47 INFO - "buildid": "20161026005405", 01:00:47 INFO - "stage_platform": "linux64-pgo", 01:00:47 INFO - "basedir": "/builds/slave/test", 01:00:47 INFO - "buildnumber": 1662, 01:00:47 INFO - "platform": "ubuntu64_hw", 01:00:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:00:47 INFO - "slavebuilddir": "test", 01:00:47 INFO - "branch": "fx-team", 01:00:47 INFO - "revision": "b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1", 01:00:47 INFO - "slavename": "talos-linux64-ix-057", 01:00:47 INFO - "builduid": "f6f42133af3d4a27a1bc55714ff42051", 01:00:47 INFO - "repo_path": "integration/fx-team" 01:00:47 INFO - } 01:00:47 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:00:47 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 01:00:47 INFO - Running post-action listener: _resource_record_post_action 01:00:47 INFO - [mozharness: 2016-10-26 08:00:47.833779Z] Finished read-buildbot-config step (success) 01:00:47 INFO - [mozharness: 2016-10-26 08:00:47.833867Z] Running download-and-extract step. 01:00:47 INFO - Running pre-action listener: _resource_record_pre_action 01:00:47 INFO - Running main action method: download_and_extract 01:00:47 INFO - mkdir: /builds/slave/test/build/tests 01:00: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')]} 01:00:47 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:00:47 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/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 01:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/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 01:00:47 INFO - Downloaded 1361 bytes. 01:00:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:00:47 INFO - Using the following test package requirements: 01:00:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:00:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:00:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:00:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:00:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:00:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:00:47 INFO - u'jsshell-linux-x86_64.zip'], 01:00:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:00:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:00:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:00:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:00:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:00:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:00:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:00:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:00:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:00:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:00:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:00:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:00: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/1477456211/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:00: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/1477456211/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:00:47 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:00:47 INFO - Http code: 200 01:00:47 INFO - via: 1.1 4a7b695b8ae560fe9087da065a2b7812.cloudfront.net (CloudFront) 01:00:47 INFO - x-amz-cf-id: VXh0OTwc7ZwJIrvRPTqYayL_rMBfFqXtMKgvNbmHdGtLFK6zb513pQ== 01:00:47 INFO - x-amz-replication-status: COMPLETED 01:00:47 INFO - x-amz-version-id: zvb8e80JOMwBIzP8UjRd9lPEbtvw77Bq 01:00:48 INFO - Expected file size: 22036204 01:00:48 INFO - Obtained file size: 22036204 01:00: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 01:00: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/1477456211/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:00: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/1477456211/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:00:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:00:52 INFO - Http code: 200 01:00:52 INFO - via: 1.1 8e86372eaaa62fc64b70e7bcde725dd9.cloudfront.net (CloudFront) 01:00:52 INFO - x-amz-cf-id: gzsffLMqZULoMwuOJLW6pmwIEfX-UXcKr_xW2tNKVMywO7jqXfz-Hg== 01:00:52 INFO - x-amz-replication-status: COMPLETED 01:00:52 INFO - x-amz-version-id: zvb8e80JOMwBIzP8UjRd9lPEbtvw77Bq 01:00:52 INFO - Expected file size: 22036204 01:00:52 INFO - Obtained file size: 22036204 01:00: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/1477456211/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:00: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/1477456211/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:00:57 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:00:57 INFO - Http code: 200 01:00:57 INFO - via: 1.1 b04a4cffa8fb4f524ff7edcab1b5ae31.cloudfront.net (CloudFront) 01:00:57 INFO - x-amz-cf-id: rzc3ymUO9WPSc21F7X4Cs19bJxYJLkIi-sSp6i5pX6xmMueB5VteUQ== 01:00:57 INFO - x-amz-replication-status: COMPLETED 01:00:57 INFO - x-amz-version-id: qQ_zTmf2c5g25oboiRPGc3Qsh8Bryy7d 01:00:57 INFO - Expected file size: 14409028 01:00:57 INFO - Obtained file size: 14409028 01:00: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')]} 01:00:57 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:00:57 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/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 01:00:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/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 01:00:58 INFO - Downloaded 59300889 bytes. 01:00:58 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:00:58 INFO - mkdir: /builds/slave/test/properties 01:00:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:00:58 INFO - Writing to file /builds/slave/test/properties/build_url 01:00:58 INFO - Contents: 01:00:58 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:00:58 INFO - Running post-action listener: _resource_record_post_action 01:00:58 INFO - Running post-action listener: set_extra_try_arguments 01:00:58 INFO - [mozharness: 2016-10-26 08:00:58.486880Z] Finished download-and-extract step (success) 01:00:58 INFO - [mozharness: 2016-10-26 08:00:58.487107Z] Running populate-webroot step. 01:00:58 INFO - Running pre-action listener: _resource_record_pre_action 01:00:58 INFO - Running main action method: populate_webroot 01:00:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:00:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:00:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:00:58 INFO - '--tppagecycles', 01:00:58 INFO - '7'], 01:00:58 INFO - 'tests': ['tsvgm']}}, 01:00:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:00:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:00:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:00:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:00:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:58 INFO - 'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:58 INFO - 'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['damp', 'tps']}, 01:00:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:58 INFO - 'tests': ['damp', 'tps']}, 01:00:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['dromaeo_dom']}, 01:00:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:00:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['basic_compositor_video']}, 01:00:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:00:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['a11yr', 01:00:58 INFO - 'ts_paint', 01:00:58 INFO - 'tpaint', 01:00:58 INFO - 'sessionrestore', 01:00:58 INFO - 'sessionrestore_no_auto_restore', 01:00:58 INFO - 'tabpaint']}, 01:00:58 INFO - 'other-e10s': {'tests': ['a11yr', 01:00:58 INFO - 'ts_paint', 01:00:58 INFO - 'tpaint', 01:00:58 INFO - 'sessionrestore', 01:00:58 INFO - 'sessionrestore_no_auto_restore', 01:00:58 INFO - 'tabpaint']}, 01:00:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:00:58 INFO - 'ts_paint', 01:00:58 INFO - 'tpaint', 01:00:58 INFO - 'sessionrestore', 01:00:58 INFO - 'sessionrestore_no_auto_restore', 01:00:58 INFO - 'tabpaint']}, 01:00:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:00:58 INFO - 'ts_paint', 01:00:58 INFO - 'tpaint', 01:00:58 INFO - 'sessionrestore', 01:00:58 INFO - 'sessionrestore_no_auto_restore', 01:00:58 INFO - 'tabpaint']}, 01:00:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['a11yr', 01:00:58 INFO - 'ts_paint', 01:00:58 INFO - 'tpaint', 01:00:58 INFO - 'sessionrestore', 01:00:58 INFO - 'sessionrestore_no_auto_restore', 01:00:58 INFO - 'tabpaint']}, 01:00:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['a11yr', 01:00:58 INFO - 'ts_paint', 01:00:58 INFO - 'tpaint', 01:00:58 INFO - 'sessionrestore', 01:00:58 INFO - 'sessionrestore_no_auto_restore', 01:00:58 INFO - 'tabpaint']}, 01:00:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['tsvgx', 01:00:58 INFO - 'tsvgr_opacity', 01:00:58 INFO - 'tart', 01:00:58 INFO - 'tscrollx', 01:00:58 INFO - 'cart']}, 01:00:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:00:58 INFO - 'tsvgr_opacity', 01:00:58 INFO - 'tart', 01:00:58 INFO - 'tscrollx', 01:00:58 INFO - 'cart']}, 01:00:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:58 INFO - 'talos_options': ['--disable-e10s'], 01:00:58 INFO - 'tests': ['tp5o']}, 01:00:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:58 INFO - 'tests': ['tp5o']}, 01:00:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:58 INFO - 'talos_options': ['--disable-e10s', 01:00:58 INFO - '--xperf_path', 01:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:58 INFO - 'tests': ['tp5n']}, 01:00:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:58 INFO - 'talos_options': ['--xperf_path', 01:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:58 INFO - 'tests': ['tp5n']}}, 01:00:58 INFO - 'talos.zip': {'path': '', 01:00:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:00:58 INFO - Running post-action listener: _resource_record_post_action 01:00:58 INFO - [mozharness: 2016-10-26 08:00:58.508796Z] Finished populate-webroot step (success) 01:00:58 INFO - [mozharness: 2016-10-26 08:00:58.508883Z] Running create-virtualenv step. 01:00:58 INFO - Running pre-action listener: _resource_record_pre_action 01:00:58 INFO - Running main action method: create_virtualenv 01:00:58 INFO - Creating virtualenv /builds/slave/test/build/venv 01:00: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 01:00:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:00:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:00:58 INFO - Using real prefix '/usr' 01:00:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:00:59 INFO - Installing distribute.............................................................................................................................................................................................done. 01:01:01 INFO - Installing pip.................done. 01:01:01 INFO - Return code: 0 01:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:01:01 INFO - Reading from file tmpfile_stdout 01:01:01 INFO - Output received: 01:01: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) 01:01:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01: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 01:01: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 01:01:01 INFO - Using env: {'DISPLAY': ':0', 01:01:01 INFO - 'HOME': '/home/cltbld', 01:01:01 INFO - 'LANG': 'en_US.UTF-8', 01:01:01 INFO - 'LANGUAGE': 'en_US:en', 01:01:01 INFO - 'LOGNAME': 'cltbld', 01:01:01 INFO - 'MAIL': '/var/mail/cltbld', 01:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:01 INFO - 'MOZ_NO_REMOTE': '1', 01:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:01 INFO - 'NO_EM_RESTART': '1', 01:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:01 INFO - 'PWD': '/builds/slave/test', 01:01:01 INFO - 'SHELL': '/bin/bash', 01:01:01 INFO - 'SHLVL': '1', 01:01:01 INFO - 'TERM': 'linux', 01:01:01 INFO - 'TMOUT': '86400', 01:01:01 INFO - 'USER': 'cltbld', 01:01:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:01 INFO - '_': '/tools/buildbot/bin/python'} 01:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01: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 01:01:01 INFO - Cleaning up... 01:01:01 INFO - Return code: 0 01:01:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01: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 01:01: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 01:01:01 INFO - Using env: {'DISPLAY': ':0', 01:01:01 INFO - 'HOME': '/home/cltbld', 01:01:01 INFO - 'LANG': 'en_US.UTF-8', 01:01:01 INFO - 'LANGUAGE': 'en_US:en', 01:01:01 INFO - 'LOGNAME': 'cltbld', 01:01:01 INFO - 'MAIL': '/var/mail/cltbld', 01:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:01 INFO - 'MOZ_NO_REMOTE': '1', 01:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:01 INFO - 'NO_EM_RESTART': '1', 01:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:01 INFO - 'PWD': '/builds/slave/test', 01:01:01 INFO - 'SHELL': '/bin/bash', 01:01:01 INFO - 'SHLVL': '1', 01:01:01 INFO - 'TERM': 'linux', 01:01:01 INFO - 'TMOUT': '86400', 01:01:01 INFO - 'USER': 'cltbld', 01:01:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:01 INFO - '_': '/tools/buildbot/bin/python'} 01:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:01 INFO - Downloading/unpacking psutil>=3.1.1 01:01:01 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 01:01:01 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 01:01:01 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 01:01:01 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 01:01:01 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 01:01:01 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 01:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:01:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:01:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:01:03 INFO - Installing collected packages: psutil 01:01:03 INFO - Running setup.py install for psutil 01:01:03 INFO - building 'psutil._psutil_linux' extension 01:01:03 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 01:01: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 01:01:04 INFO - building 'psutil._psutil_posix' extension 01:01: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 01:01: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 01:01:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:01:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:01:04 INFO - Successfully installed psutil 01:01:04 INFO - Cleaning up... 01:01:04 INFO - Return code: 0 01:01:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01: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 01:01: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 01:01:04 INFO - Using env: {'DISPLAY': ':0', 01:01:04 INFO - 'HOME': '/home/cltbld', 01:01:04 INFO - 'LANG': 'en_US.UTF-8', 01:01:04 INFO - 'LANGUAGE': 'en_US:en', 01:01:04 INFO - 'LOGNAME': 'cltbld', 01:01:04 INFO - 'MAIL': '/var/mail/cltbld', 01:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:04 INFO - 'MOZ_NO_REMOTE': '1', 01:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:04 INFO - 'NO_EM_RESTART': '1', 01:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:04 INFO - 'PWD': '/builds/slave/test', 01:01:04 INFO - 'SHELL': '/bin/bash', 01:01:04 INFO - 'SHLVL': '1', 01:01:04 INFO - 'TERM': 'linux', 01:01:04 INFO - 'TMOUT': '86400', 01:01:04 INFO - 'USER': 'cltbld', 01:01:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:04 INFO - '_': '/tools/buildbot/bin/python'} 01:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:01:06 INFO - Installing collected packages: mozsystemmonitor 01:01:06 INFO - Running setup.py install for mozsystemmonitor 01:01:06 INFO - Successfully installed mozsystemmonitor 01:01:06 INFO - Cleaning up... 01:01:06 INFO - Return code: 0 01:01:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:01:06 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')]} 01:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:06 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')]} 01:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:06 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 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01:06 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 01:01:06 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 01:01:06 INFO - Using env: {'DISPLAY': ':0', 01:01:06 INFO - 'HOME': '/home/cltbld', 01:01:06 INFO - 'LANG': 'en_US.UTF-8', 01:01:06 INFO - 'LANGUAGE': 'en_US:en', 01:01:06 INFO - 'LOGNAME': 'cltbld', 01:01:06 INFO - 'MAIL': '/var/mail/cltbld', 01:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:06 INFO - 'MOZ_NO_REMOTE': '1', 01:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:06 INFO - 'NO_EM_RESTART': '1', 01:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:06 INFO - 'PWD': '/builds/slave/test', 01:01:06 INFO - 'SHELL': '/bin/bash', 01:01:06 INFO - 'SHLVL': '1', 01:01:06 INFO - 'TERM': 'linux', 01:01:06 INFO - 'TMOUT': '86400', 01:01:06 INFO - 'USER': 'cltbld', 01:01:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:06 INFO - '_': '/tools/buildbot/bin/python'} 01:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:06 INFO - Downloading/unpacking jsonschema==2.5.1 01:01:06 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 01:01:06 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 01:01:06 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 01:01:06 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 01:01:06 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 01:01:06 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 01:01:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:01:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:01:09 INFO - warning: no files found matching '*.txt' 01:01:09 INFO - no previously-included directories found matching 'build' 01:01:09 INFO - no previously-included directories found matching 'dist' 01:01:09 INFO - no previously-included directories found matching '.git*' 01:01:09 INFO - Installing collected packages: jsonschema, functools32 01:01:09 INFO - Running setup.py install for functools32 01:01:09 INFO - warning: no files found matching '*.txt' 01:01:09 INFO - no previously-included directories found matching 'build' 01:01:09 INFO - no previously-included directories found matching 'dist' 01:01:09 INFO - no previously-included directories found matching '.git*' 01:01:09 INFO - Successfully installed jsonschema functools32 01:01:09 INFO - Cleaning up... 01:01:09 INFO - Return code: 0 01:01:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01: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 01:01: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 01:01:09 INFO - Using env: {'DISPLAY': ':0', 01:01:09 INFO - 'HOME': '/home/cltbld', 01:01:09 INFO - 'LANG': 'en_US.UTF-8', 01:01:09 INFO - 'LANGUAGE': 'en_US:en', 01:01:09 INFO - 'LOGNAME': 'cltbld', 01:01:09 INFO - 'MAIL': '/var/mail/cltbld', 01:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:09 INFO - 'MOZ_NO_REMOTE': '1', 01:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:09 INFO - 'NO_EM_RESTART': '1', 01:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:09 INFO - 'PWD': '/builds/slave/test', 01:01:09 INFO - 'SHELL': '/bin/bash', 01:01:09 INFO - 'SHLVL': '1', 01:01:09 INFO - 'TERM': 'linux', 01:01:09 INFO - 'TMOUT': '86400', 01:01:09 INFO - 'USER': 'cltbld', 01:01:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:09 INFO - '_': '/tools/buildbot/bin/python'} 01:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:01:09 INFO - Cleaning up... 01:01:09 INFO - Return code: 0 01:01:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01: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 01:01: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 01:01:09 INFO - Using env: {'DISPLAY': ':0', 01:01:09 INFO - 'HOME': '/home/cltbld', 01:01:09 INFO - 'LANG': 'en_US.UTF-8', 01:01:09 INFO - 'LANGUAGE': 'en_US:en', 01:01:09 INFO - 'LOGNAME': 'cltbld', 01:01:09 INFO - 'MAIL': '/var/mail/cltbld', 01:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:09 INFO - 'MOZ_NO_REMOTE': '1', 01:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:09 INFO - 'NO_EM_RESTART': '1', 01:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:09 INFO - 'PWD': '/builds/slave/test', 01:01:09 INFO - 'SHELL': '/bin/bash', 01:01:09 INFO - 'SHLVL': '1', 01:01:09 INFO - 'TERM': 'linux', 01:01:09 INFO - 'TMOUT': '86400', 01:01:09 INFO - 'USER': 'cltbld', 01:01:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:09 INFO - '_': '/tools/buildbot/bin/python'} 01:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:09 INFO - Downloading/unpacking blobuploader==1.2.4 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01:11 INFO - Downloading blobuploader-1.2.4.tar.gz 01:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:01:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:01:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01:12 INFO - Downloading docopt-0.6.1.tar.gz 01:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:01:12 INFO - Installing collected packages: blobuploader, requests, docopt 01:01:12 INFO - Running setup.py install for blobuploader 01:01:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:01:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:01:12 INFO - Running setup.py install for requests 01:01:12 INFO - Running setup.py install for docopt 01:01:12 INFO - Successfully installed blobuploader requests docopt 01:01:12 INFO - Cleaning up... 01:01:13 INFO - Return code: 0 01:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01: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 01:01: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 01:01:13 INFO - Using env: {'DISPLAY': ':0', 01:01:13 INFO - 'HOME': '/home/cltbld', 01:01:13 INFO - 'LANG': 'en_US.UTF-8', 01:01:13 INFO - 'LANGUAGE': 'en_US:en', 01:01:13 INFO - 'LOGNAME': 'cltbld', 01:01:13 INFO - 'MAIL': '/var/mail/cltbld', 01:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:13 INFO - 'MOZ_NO_REMOTE': '1', 01:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:13 INFO - 'NO_EM_RESTART': '1', 01:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:13 INFO - 'PWD': '/builds/slave/test', 01:01:13 INFO - 'SHELL': '/bin/bash', 01:01:13 INFO - 'SHLVL': '1', 01:01:13 INFO - 'TERM': 'linux', 01:01:13 INFO - 'TMOUT': '86400', 01:01:13 INFO - 'USER': 'cltbld', 01:01:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:13 INFO - '_': '/tools/buildbot/bin/python'} 01:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:01:13 INFO - Running setup.py (path:/tmp/pip-Qij7iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:01:13 INFO - Running setup.py (path:/tmp/pip-HPFzcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:01:13 INFO - Running setup.py (path:/tmp/pip-3Pt9Nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:01:13 INFO - Running setup.py (path:/tmp/pip-NZcicN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:01:13 INFO - Running setup.py (path:/tmp/pip-lXmHEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:01:13 INFO - Running setup.py (path:/tmp/pip-3rc72t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:01:13 INFO - Running setup.py (path:/tmp/pip-1IdJdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:01:13 INFO - Running setup.py (path:/tmp/pip-tbCrDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:01:13 INFO - Running setup.py (path:/tmp/pip-8P5NwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:01:13 INFO - Running setup.py (path:/tmp/pip-LsT_Ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:01:14 INFO - Running setup.py (path:/tmp/pip-Y0MDOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:01:14 INFO - Running setup.py (path:/tmp/pip-A8913I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:01:14 INFO - Running setup.py (path:/tmp/pip-OZO_VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:01:14 INFO - Running setup.py (path:/tmp/pip-yj2VMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:14 INFO - Running setup.py (path:/tmp/pip-G616dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:01:14 INFO - Running setup.py (path:/tmp/pip-nRjLCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:01:14 INFO - Running setup.py (path:/tmp/pip-oUTtyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:01:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:01:14 INFO - Running setup.py install for manifestparser 01:01:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:01:14 INFO - Running setup.py install for mozcrash 01:01:14 INFO - Running setup.py install for mozdebug 01:01:14 INFO - Running setup.py install for mozdevice 01:01:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:01:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:01:14 INFO - Running setup.py install for mozfile 01:01:15 INFO - Running setup.py install for mozhttpd 01:01:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Running setup.py install for mozinfo 01:01:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Running setup.py install for mozInstall 01:01:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Running setup.py install for mozleak 01:01:15 INFO - Running setup.py install for mozlog 01:01:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Running setup.py install for moznetwork 01:01:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Running setup.py install for mozprocess 01:01:15 INFO - Running setup.py install for mozprofile 01:01:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Running setup.py install for mozrunner 01:01:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:01:15 INFO - Running setup.py install for mozscreenshot 01:01:16 INFO - Running setup.py install for moztest 01:01:16 INFO - Running setup.py install for mozversion 01:01:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:01:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:01:16 INFO - Cleaning up... 01:01:16 INFO - Return code: 0 01:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01: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 01:01: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 01:01:16 INFO - Using env: {'DISPLAY': ':0', 01:01:16 INFO - 'HOME': '/home/cltbld', 01:01:16 INFO - 'LANG': 'en_US.UTF-8', 01:01:16 INFO - 'LANGUAGE': 'en_US:en', 01:01:16 INFO - 'LOGNAME': 'cltbld', 01:01:16 INFO - 'MAIL': '/var/mail/cltbld', 01:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:16 INFO - 'MOZ_NO_REMOTE': '1', 01:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:16 INFO - 'NO_EM_RESTART': '1', 01:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:16 INFO - 'PWD': '/builds/slave/test', 01:01:16 INFO - 'SHELL': '/bin/bash', 01:01:16 INFO - 'SHLVL': '1', 01:01:16 INFO - 'TERM': 'linux', 01:01:16 INFO - 'TMOUT': '86400', 01:01:16 INFO - 'USER': 'cltbld', 01:01:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:16 INFO - '_': '/tools/buildbot/bin/python'} 01:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:01:16 INFO - Running setup.py (path:/tmp/pip-QbEH5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:01:16 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)) 01:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:01:16 INFO - Running setup.py (path:/tmp/pip-4Kizja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:01:16 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)) 01:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:01:16 INFO - Running setup.py (path:/tmp/pip-ivTwR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:01:16 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)) 01:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:01:16 INFO - Running setup.py (path:/tmp/pip-fQLSBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:01:16 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)) 01:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:01:16 INFO - Running setup.py (path:/tmp/pip-iPg4HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:01:16 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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:01:17 INFO - Running setup.py (path:/tmp/pip-AcSbZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:01: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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:01:17 INFO - Running setup.py (path:/tmp/pip-ZD07tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:01: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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:01:17 INFO - Running setup.py (path:/tmp/pip-x_qyL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:01: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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:01:17 INFO - Running setup.py (path:/tmp/pip-eY69WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:01: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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:01:17 INFO - Running setup.py (path:/tmp/pip-RLgppo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:01: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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:01:17 INFO - Running setup.py (path:/tmp/pip-EedICG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:01:17 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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:01:17 INFO - Running setup.py (path:/tmp/pip-T1A8Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:01:17 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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:01:17 INFO - Running setup.py (path:/tmp/pip-CDWPcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:01:17 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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:01:17 INFO - Running setup.py (path:/tmp/pip-ta8JTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:01:17 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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:17 INFO - Running setup.py (path:/tmp/pip-dcuHse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:17 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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:01:17 INFO - Running setup.py (path:/tmp/pip-R1W7Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:01:17 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)) 01:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:01:17 INFO - Running setup.py (path:/tmp/pip-0S8T0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:01:17 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)) 01:01:17 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)) 01:01:17 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)) 01:01:17 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)) 01:01:17 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)) 01:01:17 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)) 01:01:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:19 INFO - Downloading blessings-1.6.tar.gz 01:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:01:20 INFO - Installing collected packages: blessings 01:01:20 INFO - Running setup.py install for blessings 01:01:20 INFO - Successfully installed blessings 01:01:20 INFO - Cleaning up... 01:01:20 INFO - Return code: 0 01:01:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:01:20 INFO - Reading from file tmpfile_stdout 01:01:20 INFO - Current package versions: 01:01:20 INFO - argparse == 1.2.1 01:01:20 INFO - blessings == 1.6 01:01:20 INFO - blobuploader == 1.2.4 01:01:20 INFO - docopt == 0.6.1 01:01:20 INFO - functools32 == 3.2.3-2 01:01:20 INFO - jsonschema == 2.5.1 01:01:20 INFO - manifestparser == 1.1 01:01:20 INFO - mozInstall == 1.12 01:01:20 INFO - mozcrash == 0.17 01:01:20 INFO - mozdebug == 0.1 01:01:20 INFO - mozdevice == 0.48 01:01:20 INFO - mozfile == 1.2 01:01:20 INFO - mozhttpd == 0.7 01:01:20 INFO - mozinfo == 0.9 01:01:20 INFO - mozleak == 0.1 01:01:20 INFO - mozlog == 3.4 01:01:20 INFO - moznetwork == 0.27 01:01:20 INFO - mozprocess == 0.23 01:01:20 INFO - mozprofile == 0.28 01:01:20 INFO - mozrunner == 6.12 01:01:20 INFO - mozscreenshot == 0.1 01:01:20 INFO - mozsystemmonitor == 0.3 01:01:20 INFO - moztest == 0.7 01:01:20 INFO - mozversion == 1.4 01:01:20 INFO - psutil == 3.1.1 01:01:20 INFO - requests == 1.2.3 01:01:20 INFO - wsgiref == 0.1.2 01:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01: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 01:01: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 01:01:20 INFO - Using env: {'DISPLAY': ':0', 01:01:20 INFO - 'HOME': '/home/cltbld', 01:01:20 INFO - 'LANG': 'en_US.UTF-8', 01:01:20 INFO - 'LANGUAGE': 'en_US:en', 01:01:20 INFO - 'LOGNAME': 'cltbld', 01:01:20 INFO - 'MAIL': '/var/mail/cltbld', 01:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:20 INFO - 'MOZ_NO_REMOTE': '1', 01:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:20 INFO - 'NO_EM_RESTART': '1', 01:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:20 INFO - 'PWD': '/builds/slave/test', 01:01:20 INFO - 'SHELL': '/bin/bash', 01:01:20 INFO - 'SHLVL': '1', 01:01:20 INFO - 'TERM': 'linux', 01:01:20 INFO - 'TMOUT': '86400', 01:01:20 INFO - 'USER': 'cltbld', 01:01:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:20 INFO - '_': '/tools/buildbot/bin/python'} 01:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:20 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)) 01:01:20 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)) 01:01:20 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)) 01:01:20 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)) 01:01:20 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)) 01:01:20 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)) 01:01:20 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)) 01:01:20 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)) 01:01:20 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)) 01:01:20 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)) 01:01:20 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)) 01:01:20 INFO - Cleaning up... 01:01:20 INFO - Return code: 0 01:01:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1816e2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', '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 01:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:01:20 INFO - Using env: {'DISPLAY': ':0', 01:01:20 INFO - 'HOME': '/home/cltbld', 01:01:20 INFO - 'LANG': 'en_US.UTF-8', 01:01:20 INFO - 'LANGUAGE': 'en_US:en', 01:01:20 INFO - 'LOGNAME': 'cltbld', 01:01:20 INFO - 'MAIL': '/var/mail/cltbld', 01:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:20 INFO - 'MOZ_NO_REMOTE': '1', 01:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:20 INFO - 'NO_EM_RESTART': '1', 01:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:20 INFO - 'PWD': '/builds/slave/test', 01:01:20 INFO - 'SHELL': '/bin/bash', 01:01:20 INFO - 'SHLVL': '1', 01:01:20 INFO - 'TERM': 'linux', 01:01:20 INFO - 'TMOUT': '86400', 01:01:20 INFO - 'USER': 'cltbld', 01:01:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:20 INFO - '_': '/tools/buildbot/bin/python'} 01:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:01:20 INFO - Cleaning up... 01:01:20 INFO - Return code: 0 01:01:20 INFO - Running post-action listener: _resource_record_post_action 01:01:20 INFO - Running post-action listener: _start_resource_monitoring 01:01:20 INFO - Starting resource monitoring. 01:01:20 INFO - [mozharness: 2016-10-26 08:01:20.907459Z] Finished create-virtualenv step (success) 01:01:20 INFO - [mozharness: 2016-10-26 08:01:20.907968Z] Running install step. 01:01:20 INFO - Running pre-action listener: _resource_record_pre_action 01:01:20 INFO - Running main action method: install 01:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:01:21 INFO - Reading from file tmpfile_stdout 01:01:21 INFO - Detecting whether we're running mozinstall >=1.0... 01:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:01:21 INFO - Reading from file tmpfile_stdout 01:01:21 INFO - Output received: 01:01:21 INFO - Usage: mozinstall [options] installer 01:01:21 INFO - Options: 01:01:21 INFO - -h, --help show this help message and exit 01:01:21 INFO - -d DEST, --destination=DEST 01:01:21 INFO - Directory to install application into. [default: 01:01:21 INFO - "/builds/slave/test"] 01:01:21 INFO - --app=APP Application being installed. [default: firefox] 01:01:21 INFO - mkdir: /builds/slave/test/build/application 01:01: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'] 01:01: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 01:01:38 INFO - Reading from file tmpfile_stdout 01:01:38 INFO - Output received: 01:01:38 INFO - /builds/slave/test/build/application/firefox/firefox 01:01:38 INFO - Running post-action listener: _resource_record_post_action 01:01:38 INFO - [mozharness: 2016-10-26 08:01:38.078871Z] Finished install step (success) 01:01:38 INFO - [mozharness: 2016-10-26 08:01:38.079151Z] Running run-tests step. 01:01:38 INFO - Running pre-action listener: _resource_record_pre_action 01:01:38 INFO - Running main action method: run_tests 01:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:01:38 INFO - Python 2.7.3 01:01:38 INFO - Return code: 0 01:01:38 INFO - grabbing minidump binary from tooltool 01:01: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')]} 01:01: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 0x1307930>, '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 0x1308830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:01: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 01:01: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 01:01: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 01:01:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:01:38 INFO - Return code: 0 01:01:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:01:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:01:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:01:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:01:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:01: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/1477456211/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 01:01: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/1477456211/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 01:01:38 INFO - Using env: {'DISPLAY': ':0', 01:01:38 INFO - 'HOME': '/home/cltbld', 01:01:38 INFO - 'LANG': 'en_US.UTF-8', 01:01:38 INFO - 'LANGUAGE': 'en_US:en', 01:01:38 INFO - 'LOGNAME': 'cltbld', 01:01:38 INFO - 'MAIL': '/var/mail/cltbld', 01:01:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:01:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:38 INFO - 'MOZ_NO_REMOTE': '1', 01:01:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:38 INFO - 'NO_EM_RESTART': '1', 01:01:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:38 INFO - 'PWD': '/builds/slave/test', 01:01:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:01:38 INFO - 'SHELL': '/bin/bash', 01:01:38 INFO - 'SHLVL': '1', 01:01:38 INFO - 'TERM': 'linux', 01:01:38 INFO - 'TMOUT': '86400', 01:01:38 INFO - 'USER': 'cltbld', 01:01:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777', 01:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:38 INFO - '_': '/tools/buildbot/bin/python'} 01:01: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/1477456211/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 01:01:38 INFO - mozversion application_buildid: 20161025213011 01:01:38 INFO - mozversion application_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 01:01:38 INFO - mozversion application_display_name: Nightly 01:01:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:01:38 INFO - mozversion application_name: Firefox 01:01:38 INFO - mozversion application_remotingname: firefox 01:01:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:01:38 INFO - mozversion application_vendor: Mozilla 01:01:38 INFO - mozversion application_version: 52.0a1 01:01:38 INFO - mozversion platform_buildid: 20161025213011 01:01:38 INFO - mozversion platform_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 01:01:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:01:38 INFO - mozversion platform_version: 52.0a1 01:01:38 INFO - using testdate: 1477468898 01:01:38 INFO - actual date: 1477468898 01:01:38 INFO - starting webserver on 'localhost:49795' 01:01:38 INFO - SUITE-START | Running 2 tests 01:01:38 INFO - TEST-START | dromaeo_css 01:01:38 INFO - operating with platform_type : linux_ 01:01:38 INFO - Initialising browser for dromaeo_css test... 01:01:38 INFO - TEST-INFO | started process 21678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3dSOJf/profile http://localhost:49795/getInfo.html) 01:01:42 INFO - PROCESS | 21678 | __metrics Screen width/height:1600/1200 01:01:42 INFO - PROCESS | 21678 | colorDepth:24 01:01:42 INFO - PROCESS | 21678 | Browser inner width/height: 1024/697 01:01:42 INFO - PROCESS | 21678 | __metrics 01:01:43 INFO - PROCESS | 21678 | 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" 01:01:43 INFO - PROCESS | 21678 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:01:43 INFO - PROCESS | 21678 | console.error: PushService: 01:01:43 INFO - PROCESS | 21678 | stateChangeProcessEnqueue: Error transitioning state 01:01:43 INFO - PROCESS | 21678 | UnknownError 01:01:44 INFO - TEST-INFO | 21678: exit 0 01:01:44 INFO - Browser initialized. 01:01:44 INFO - Running cycle 1/1 for dromaeo_css test... 01:01:44 INFO - TEST-INFO | started process 21762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3dSOJf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:01:56 INFO - PROCESS | 21762 | RSS: Main: 171339776 01:01:56 INFO - PROCESS | 21762 | 01:02:47 INFO - PROCESS | 21762 | 1477468967592 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] 01:04:59 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49795/tests/dromaeo/cssquery-ext.html) 01:05:00 INFO - PROCESS | 21762 | RSS: Main: 298409984 01:05:00 INFO - PROCESS | 21762 | 01:08:02 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-ext.html (next: http://localhost:49795/tests/dromaeo/cssquery-jquery.html) 01:08:03 INFO - PROCESS | 21762 | RSS: Main: 272134144 01:08:03 INFO - PROCESS | 21762 | 01:11:05 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49795/tests/dromaeo/cssquery-mootools.html) 01:11:06 INFO - PROCESS | 21762 | RSS: Main: 214839296 01:11:06 INFO - PROCESS | 21762 | 01:14:08 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49795/tests/dromaeo/cssquery-prototype.html) 01:14:08 INFO - PROCESS | 21762 | RSS: Main: 244957184 01:14:08 INFO - PROCESS | 21762 | 01:17:11 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49795/tests/dromaeo/cssquery-yui.html) 01:17:11 INFO - PROCESS | 21762 | RSS: Main: 216961024 01:17:11 INFO - PROCESS | 21762 | 01:20:14 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-yui.html (next: http://localhost:49795/tests/dromaeo/cssquery-dojo.html) 01:20:15 INFO - PROCESS | 21762 | RSS: Main: 307818496 01:20:15 INFO - PROCESS | 21762 | 01:20:15 INFO - PROCESS | 21762 | __start_tp_report 01:20:15 INFO - PROCESS | 21762 | _x_x_mozilla_page_load 01:20:15 INFO - PROCESS | 21762 | _x_x_mozilla_page_load_details 01:20:15 INFO - PROCESS | 21762 | |i|pagename|runs| 01:20:15 INFO - PROCESS | 21762 | |0;dojo.html;3050.786444948854;3066.3867226554694;3080.1221651829233;3095.9380812383765;3118.0022392834303;5147.588192944565;5191.0656081905245;5191.117510023296;5271.604629652777;5283;5254.7635356408955;5270.4729527047275;5285.392179899312;5287.444818294081;5291.994521041;4761.785719642625;4792.424909010923;4800.063987522434;4838.491958344376;4840.806367745286;4842.418909730837;4848.854534363957;4888.120138375109;4890.21756518957;4893.902121957559;4807.302941073543;4826.710397376169;4849.369581954341;4852.126617208901;4884.804607815701;4833.03339332135;4870.245112007627;4890.24201248807;4891.192953162759;4943.975280123613;4610.723356598614;4651.813927442899;4781.091592597395;4792.688475249098;4827.082854257715;5285.312909321764;5298.6555873868465;5299.284596579451;5314.309139811839;5365.651232669864;5614.410486898858;5669.433056694339;5676.489115979541;5678.375378708339;5757.913631295534;5534.916976245319;5540.695261760601;5559.471850174227;5564.527015203713;5718.5711071669375;5159.819406320836;5186.273921650972;5189.221616757516;5227.085260079471;5236.083685355085;5637.295338082739;5641.069223578145;5643;5643.7742490299925;5715.885682286331;5416.51251387377;5477.972610136924;5484.232207490954;5513.558915286848;5520.696361700145;5620.718964051781;5627.268455100811;5630.155476678449;5694.487496125285;5703.058995265817;5550.805721799798;5589.217509548666;5593.664380137205;5598.44015598445;5599.664020158803;5463.098588732894;5479.0959491684225;5519.254900588369;5544.833654990357;5657.038303488417;4301.913961720748;4323.308270676676;4351.042770590465;4363.738175709467;4364.10535840152;3838.5777564467885;3839.5584507781405;3841.0397400649836;3872.903177420587;3879.1271963807917;5199.610029247821;5349.679019258857;5362.168863826113;5362.785488580413;5369.006733754268;5513.228148059275;5586.944130558642;5610.102383618601;5636.098224284095;5707.486326230659;5304.9734751326;5316.308879845596;5316.973415132899;5320.255164277004;5322.042032434121;4860.246661767432;4869.123557759637;4874.46380898101;4883.4628190898975;4916.803327866845;5689.68706721126;5738.741756620962;5780.797672081457;5829;5830.679312637676;5631.408702086222;5631.8592035199445;5635.464630860061;5651.039323314964;5687.800926967537;5693.231413759089;5751.1085781703905;5751.281089863767;5752.71236438168;5812.912806307824;5348.572114230775;5390.083685773507;5396.379416367011;5482.17767334903;5489.725513724218;5609.775608975595;5613.971930140323;5615.410381909841;5624.493795558255;5681.630694004876;5484;5488.396276409512;5495.258140151029;5497.038018346693;5498.505134537911;5286.867828304323;5347.759350829144;5452.427495112956;5456.127019676833;5522.944770552243;5453.372862120907;5471.72641367938;5479.397266300624;5520.7515661796115;5547.278853748987;5546.611737178358;5555.666660000413;5556.305461817273;5558.694271814928;5562.360328562268;5266;5268.236105764566;5318.016167009116;5327.467253274642;5345.091334473072 01:20:15 INFO - PROCESS | 21762 | |1;ext.html;554.4704806909402;590.4272855330329;622.1787240842089;636.0745115856427;662.393909572741;31449.842750786243;40496.39255411168;41795.16409671812;41865.99999999996;41880.16239675205;43206;43518.34722479165;43680.3447948281;43719.78140109303;43777.56222437783;8032;8769.429987050837;8919.24186444153;9043.502607356593;9053.366264361497;8103.554304513249;10525.894741052569;10786.676399708022;10809.621663241787;11192.160587955896;10976.341419514854;11035.889641103606;11050.723731906686;11052.668419947415;11068.225224234307;10830.783384332308;10904.291221070605;10907.454627268684;10907.83638245427;10912.836307455394;10711.089557387631;10718.571257149704;10758.462076896201;10779.946100269526;10787.137029037658;41309.793451032856;41523.7923810379;41619.58380416188;41666.37500437496;41703.1659366814;3575.4279315309686;3601.423772196436;3642.5993140754495;3854.672352850011;4033.233685599727;31298.687013129806;31534.211644708837;31545.52681709776;31803.522947155812;31848.522272165705;4241;4259.5740425957465;4524.8190072397065;4539.72761634303;4552.726836389827;327121;328307;328880;329022;329098;32585.348293034007;54477.45522544803;54920.45079549153;54926.45073549293;54936;34083.318333633186;35668;35760.821195893855;35795.64204357975;35810.8074329226;13562.864371356358;13593;13641.522546710818;13695.452181912611;13707.725845483035;10000.499975001221;10224.284300098921;10811.297265677706;11184.720381990353;11258.605948791754;7960.164182760843;7996.800079998046;8127.471714338549;8139.511629302261;8147.674093036212;3214.3571285742946;3221.130294820385;3228.305914228405;3263.2005158735788;3295.802251864896;990.2474119669104;1010.6765834932897;1069.2568664777905;1112.8942750438696;1115.1246271676857;29524;31681.683183167872;31739.52390714141;31766.205844854063;32274.83862580719;1061.8194906865851;1078.7087486378791;1082.2370228988702;1102.1127991966384;1156.809126494119;15748.527544173694;16514.83485165157;16546.172691365624;16593.336266549202;16611.91694041522;556227;569761;570464;572657;575220;55330.17004744932;55930.44069559252;55952;55973.72013139908;56085.7195714027;1204.8493938257718;1208.2206976500108;1272.1349482352089;1325.7414804113298;1331.9667008324675;30219.395612088076;32716.83641581777;32943.50584741279;33075.66924330726;33256.667433325354;46860.53139468562;47311.999999998625;47346;47373.763131184125;47508.76245618888;387217;390852;391325;392214;392392;26225.606615901157;26571.867140664173;27267;27334.48980918126;28366.716332837233;44685;44910.55089449194;44913.77543112264;45620.54379456163;46478.76760616175;37745.433818492194;38525;38726;40029;40086.599134008284;37655.811720942314;38255;39008.609913900495;39023.80488097541;39549;38274.425883612326;38716.80641596774;38725;38869.80565097156;39116.6088339113;31417.371652566362;34138.43346113501;34447.13882152966;34782.82608586941;34955.12612184614;25793.355166120997;25982.28389754251;26106.477870442865;26262.73737262603;26442.86778566095 01:20:15 INFO - PROCESS | 21762 | |2;jquery.html;367.39196629578026;385.7878167008143;388.25842640556544;392.3545767212935;407.9367698006808;14198.21909794962;18262.269509219634;19353;19555.21779128833;19736;17529.912350438262;19027.809721902813;19145.32991345303;19152.712709309373;19203.519912002208;5493.725313734317;5774.191613174159;5774.595778295521;5776.249087618604;5782.855428614297;4125.690573207006;4289.656827453812;4310.094880075188;5621.297337832771;6326.3989920957665;6356.745730170787;6397.26431460381;6399.168108145935;6406.199225096863;6415.454686351665;6152.415520525543;6312.116303717483;6334.80995570129;6343.524235682342;6399.200099987502;5378.784848606051;5597.972010139923;5602.13166959122;5605.5515558755205;5606.943930560683;20732.689009664868;21412.46468838276;22301.665475017886;22712.318630441114;22747.203847865247;2172.1311475409802;2194.648856183003;2358.469344397514;2433.3673244956262;2715.823471474348;9755.414675119515;10332.431716255604;10475.057244848;10614.978183971038;11328.376939268337;1809.3082967425498;1816.8455681267108;1846.0585101598147;1860.372174347446;1868.4394681595602;76742.6162869182;77480.99999999943;77811.61094194549;78889.21110788875;83964;10246.180305575535;10402.11582015522;10460.947695261628;10488.580456781796;10653.201009924132;14919.25403729831;14939.775903361458;14942;14954.327055282321;14972.326245318987;7312.085989251344;7421.851562968711;7586.317231449196;7652.923470765332;7679;7102.857942841218;7109.680064397011;7121.501494895411;7306.415486761046;7322.304381083789;4492.640588752892;4509.098180363941;4539.341795439643;4681.297805329228;4719.5752382285755;1928.2961718972474;1951.863369564117;1959.226105688245;1960.8039196080279;1964.4695932098252;834.7537476444463;900.5362238447204;988.0810845913226;1019.9235057370727;1035.2494441529982;18192.181351839197;18291.90854045748;18848.528786780167;18954.90522547406;18960.525986850163;931.5901003558548;940.6801687426171;941.7928055827707;959.4003747657714;964.9337482082339;9646.565904534313;10359.378437293786;10469.162467002621;10621.946890265499;10623.734406639742;452055;453329;461647;470852;471915;87156.56421717851;89914;90739;91406.54296728474;93646.53176734073;939.6241503398695;986.8815742110993;1003.433060320931;1010.1312870930993;1010.9696709098739;15863.603409914384;16359.509214723577;16696;16854.494365168575;17176.14119294055;42143.83921205861;42381.576184239;42655;42867.28459869349;42902.356464653676;56127;57410.71294643667;57934;58978.41021589729;60391.39608603858;7855.960720196363;7967.56178410193;8284.668613255402;8285.295749861329;8349.707760228363;11709.941450292694;12044.578439754567;12261.26432414058;12573.1198816082;12811.615651530095;10657.733556661145;11178.608748694081;11207.831882521932;11373.886261137282;11811.232269902428;10521;10862.728431789268;10887.891121088687;10931.18016148776;11130.944345278222;10984.835227471754;11140.275882067639;11195.552177912792;11288.661340159808;11360.431978401211;6948.756793512202;7253.202147763636;7344.779656610311;7910.841783164419;8228.670853165806;10572.682819515427;11468.197226194086;11482.311061336346;11537.192396532162;11566.768664626828 01:20:15 INFO - PROCESS | 21762 | |3;mootools.html;1322.82141910842;1439.5177615498808;1484.5546336099167;1629.535582359028;1791.6864548703973;7527.510711803736;8594.65621375145;8875.201231889128;8880.200781929625;9052.81894362114;8873.423227490208;8946.23956963659;8951;8958.865617015734;8966.865497017534;2330.3940975346363;2356.705411823522;2359.4219416243045;2359.6696462495265;2363.4800343924308;2226.8218542516643;2281.7490076091617;2288.8512246703995;2305.13557415969;2311.84972976756;2267.3764714703425;2284.1434462076722;2310.2722642367685;2315.0392587076344;2317.606006978809;2239.1491233331312;2242.8878556072295;2257.119723307911;2262.5180506768093;2262.751097379287;2254;2258.4015235962484;2258.8080013198896;2263.6265016272296;2264.6036943534814;8711.825763484758;8811.955940220321;8868.201861832402;8892.955535222283;8895.644174233023;5140.049090918192;5327.041132596131;5337.332833395825;5339.572834173296;5339.733013349317;3186.76099292554;3277.672232776727;3307.2228026413773;3313.9834300828584;3366.0743295593907;1018.0379541333443;1029.1046789293289;1069.2301542889186;1073.3398959639844;1077.9730506737317;12110.212836165621;12129.332886691229;12226.20529665569;12229.143959922809;12235.69410764729;4264.616184543406;4485.663575231805;4538.047010127844;4549.294859296814;4564.863054108382;9646.517674116267;9649.372790768577;9650.034996500433;9651.71044868655;9654.71035868925;5241.711705856214;5245.606579506552;5248.134057880483;5248.343957005374;5254.684718916801;4312.159128969884;4333.1766964276685;4724.858254252378;4747.715137091785;4926.891449423851;3557.1640664443835;3678.7976661283888;3746.157114649182;3760.680342170946;3785.1104990327253;1091.879893211746;1095.9397233152254;1108.8558487396588;1116.4585176189541;1130.0451118804597;833.954132522705;936.5270538378076;936.9344145909857;981.043482604455;1020.7856350166549;5895.9387310284565;5977.282726072812;5979.342272350038;6056.242969628796;6193.659348735863;895.2837729816121;945.1871390604075;966.9274804389559;975.11264749078;1012.1649639047815;4175.958240417557;4263.722858014219;4269.487661480643;4287.614114729689;4296.505901821331;10566.366018038942;10733.677989660322;10824.945875270574;11036.392998385167;11036.392998385167;10969;10976.835347469794;10984.835227471594;10987.230893837515;11004;7979.3616510679;8298.377621678399;8346.499210047295;8349.582520873932;8366.163383661586;5897.351291358033;5907.113932910098;5983.9401605983385;6062.060380641008;6178.876422471435;9835.065668761456;9875.901240987785;9906.25703072258;9947.552360143665;10031;9475;9771.169450596779;9780.119789219005;9911.058449447291;9947.701568952943;6464.0627109069865;6621.370969757865;6651.401373876374;7545.207753185837;7708;7567.810804729926;7750.186230445722;8108.75673729789;8185.4270201085355;8324.791880203044;7485.962570187115;7656.69373225087;7761.223877612194;7781.727639532589;7880.763577092696;7262.96368518154;7294.671739771617;7313.597752123472;7379.889301660587;7441;6922.06552115458;7013.4038606719005;7016.789496315118;7020.684069216795;7028.121484814398;4994.225894986283;5112.130937740519;5123.769430375716;5140.742962851918;5385.138377859524;5074.7716352764955;5146.69119852795;5213.139831927841;5214.400343960493;5436.429174936575 01:20:15 INFO - PROCESS | 21762 | |4;prototype.html;329.44652982988583;332.81362437035256;337.37417091295646;339.4890689512284;345.55596059064106;5066.493350664931;5224.29472021277;5237.476252374765;5291.497307755767;5311.814086506978;5087.872803179922;5150.27896094547;5191;5214.210397437372;5225.372955245366;4137.27597670408;4144.880882161815;4153.854615088472;4156.41810146579;4159.625633692967;3941.6649584785328;4112.732672376301;4170.061736109382;4172.600754566137;4179.979100104495;4088.2641124597562;4105.5894410559;4107.67138628909;4107.835686572534;4128.133092050658;4087.81604827782;4092.1611069730634;4092.9590704092875;4101.753894766323;4121;3599.6220396858475;3614.981925090384;3619.6199399063244;3623.2391197848483;3647.58052823926;5124.4106927703415;5169.2504586835075;5177.145770947789;5199.454057323965;5210.192420174879;4714.528547145258;4744.288356746481;4749.7387643679585;4765.237561990065;4765.833195838129;5393.7999563656695;5512.310961129859;5516.806911758069;5533.08704063829;5533.280673512458;3821.197548514815;3941.152652179795;3951.6641085507767;3952.486176797027;3976.443297938291;5598.636088654265;5628.409017053192;5631.71841407928;5668.291463567054;5685.772569097231;4018.1361007383553;4031.496062992126;4054.9797251014147;4066.877993660195;4086.244044851712;3898.4542164097047;4111.362738775495;4117.505899292104;4125.855595054159;4139.79301034947;4703.952960470351;4708.717476951394;4709.788059537329;4731.503192164842;4746.738929358849;5513.228148059275;5534.501894829405;5585.58108141891;5657.971710141423;5671.035923892948;1306.9085164038427;1343.4760443427072;1373.9038267321391;1390;1392.9442822287197;882.9911700882909;895.2748273898034;911.8814554107923;918.5958178401482;922.8338898998111;4616.538346165424;4639.582437580567;4688.413948256468;4689.226277664216;4698.02682873194;4893.681910675795;4897.240927656219;4914.287428322873;4943.3573635427165;4968.807486203285;4669.673122881433;4676.508966558463;4689.904662922455;4692.920628255521;4715.386999690087;2762.4475104979083;2955.2611847038243;2977.9874842553636;3017.532282496217;3032.9848350758107;5767.682777447197;5812.88374232513;5826.184334193216;5826.388229235869;5859.267591551056;5567.888642227133;5722.828315150552;5726.9713651431475;5773.480386765212;5800.216970708984;5676.262085928803;5701.800436984686;5754.360007397955;5757.740901659352;5763.184596851978;5602.663840169603;5621.269234999424;5644;5646.265985421869;5674.914876276942;5356.303680521507;5548.306461692288;5561.02682030635;5561.805336813192;5575.721213939206;5718.485336319751;5795.609053826967;5797.362290147996;5805.187273781758;5824.504917082096;4029.7104926423262;4148.357004664282;4165.271077561475;4201.684873634551;4230.513490948457;5288.947110528846;5556.499915007668;5581.832545023656;5584.855104703607;5604.691741954069;5283.524482796567;5342.504098852328;5480.780768769364;5515.283013208257;5522;5483.643563168382;5511.503964643041;5517.172424136251;5517.172424136412;5527.585431092603;5275.261463395051;5316.813911513079;5366.275552800322;5404.513593776579;5473.261109750292;5469.699166545878;5484.643498172606;5516.696581688046;5536.833894983157;5537.529310008695;5410.3778065522965;5413.945860541344;5418.729063546885;5421.322334708161;5452.945470545403 01:20:15 INFO - PROCESS | 21762 | |5;yui.html;731;745.366438527252;755.1768572256243;786.1313248860006;797.0793733238108;12581.496740130395;13224.140430871987;13229.338533073356;13333.133346332494;13378;13105;13135.146215495986;13230.603081907535;13231.13997590156;13237.271950042743;651.8696260747846;670.2526682748725;773.5822655765879;782.659543098751;805.1465446626595;792.7106606088765;793.2503783924194;798.7523867601062;799.588212070784;799.7200979657132;816.808050108224;824.9917500825005;825.154216927648;825.1789469477848;826.499967519651;685.7051467868814;702.2415790945767;830.2983978538126;830.4975489828627;830.6511265268601;601.9277686677583;617.527591392585;620.4416025576971;623.1431781300712;624.5534442873368;13367.732645347136;13429.66425839352;13485.123466974615;13538.052336336363;13538.187708737507;11690.70773230676;11853;12325.753484930252;12935.48258069676;13328.86671133286;11763;11929.164958452911;11942.701432464171;12013.339266340348;12229.510819567207;4337.934930976038;4381.715188512737;4393.077453734688;4395.329774685599;4582.083583283356;62449;62953.370466295666;67547;68122.3187768126;68271;10220.386776793417;10588.523516441779;10672.413017283969;10695.411752353695;10744.355338679548;17878;17895.284188632308;17905.10474476271;17910.28358865657;17911.820881791275;7388.261173882569;7566.659500322498;7600.201978792258;7684.116326622398;8006.959965200137;4283.443152390169;4400.647948164139;4489.057297967398;4517.661175411858;4625.907481850411;3260.136063943057;3321.285923526453;3367.915802104967;3368.427367347557;3369.4440417330866;644.5005121031238;673.1417442760519;673.161913417798;691.7682576336883;703.8803403421431;611.3244864424836;637.765922939105;673.2594146438878;740.9333160015625;752.7779305105007;9213.723588292361;9260.536973151315;9330.486823224788;9720.270979676552;9737.367071140354;724.1274264511251;724.3810084461225;735.5696917303437;740.4853626729479;751.443931490693;4333.155034768253;4642.86071417858;4654.13898428785;4657.417822772153;4677.391939047902;77130.6143469279;78958.6052069736;79497;83293;88016;45205.547944520134;55025.44974550283;70109;71165.64417177984;71283.28716712767;64036;64784;64865.35134648593;65746.67126664336;66353.66823165854;9093.681721139728;9280.211182049332;9328.160465558132;9338.346315757832;9497.905020949978;45539.54460455353;45941.31088033749;46025;47366;47870.52129478661;37051;38773;38844.688172686685;40812.38781418222;40813.795931020155;11018.614348497764;11530.979307325197;11646.301221926711;11860.924338240946;11895.048396128115;13620.93189534046;14004.859951400764;14151.64620884486;14401.927990359982;14498.85501144975;12428.75142497127;12663.493460261487;13301.135426197266;13425.127366721132;13478.73042539124;12470;12569.874301257236;13009.284489353176;13220.603381898558;13229.933850331072;12618.36908154607;12726.809097863354;12884.162529435556;13101;13162.14446061003;9222.40054396462;9370.859437108313;9566.234701224024;10043.748906277402;10198.277628665632;10662.73343166427;10738.248322617343;10928.945355273172;11040.33757974524;11100.333979960906 01:20:15 INFO - PROCESS | 21762 | __end_tp_report 01:20:15 INFO - PROCESS | 21762 | __start_cc_report 01:20:15 INFO - PROCESS | 21762 | _x_x_mozilla_cycle_collect,1181 01:20:15 INFO - PROCESS | 21762 | __end_cc_report 01:20:15 INFO - PROCESS | 21762 | __startTimestamp1477470015228__endTimestamp 01:20:15 INFO - PROCESS | 21762 | 01:20:15 INFO - PROCESS | 21762 | ------- Summary: start ------- 01:20:15 INFO - PROCESS | 21762 | Number of tests: 6 01:20:15 INFO - PROCESS | 21762 | 01:20:15 INFO - PROCESS | 21762 | [#0] dojo.html Cycles:165 Average:5218.91 Median:5369.01 stddev:570.12 (10.6%) stddev-sans-first:545.91 01:20:15 INFO - PROCESS | 21762 | Values: 3050.8 3066.4 3080.1 3095.9 3118.0 5147.6 5191.1 5191.1 5271.6 5283.0 5254.8 5270.5 5285.4 5287.4 5292.0 4761.8 4792.4 4800.1 4838.5 4840.8 4842.4 4848.9 4888.1 4890.2 4893.9 4807.3 4826.7 4849.4 4852.1 4884.8 4833.0 4870.2 4890.2 4891.2 4944.0 4610.7 4651.8 4781.1 4792.7 4827.1 5285.3 5298.7 5299.3 5314.3 5365.7 5614.4 5669.4 5676.5 5678.4 5757.9 5534.9 5540.7 5559.5 5564.5 5718.6 5159.8 5186.3 5189.2 5227.1 5236.1 5637.3 5641.1 5643.0 5643.8 5715.9 5416.5 5478.0 5484.2 5513.6 5520.7 5620.7 5627.3 5630.2 5694.5 5703.1 5550.8 5589.2 5593.7 5598.4 5599.7 5463.1 5479.1 5519.3 5544.8 5657.0 4301.9 4323.3 4351.0 4363.7 4364.1 3838.6 3839.6 3841.0 3872.9 3879.1 5199.6 5349.7 5362.2 5362.8 5369.0 5513.2 5586.9 5610.1 5636.1 5707.5 5305.0 5316.3 5317.0 5320.3 5322.0 4860.2 4869.1 4874.5 4883.5 4916.8 5689.7 5738.7 5780.8 5829.0 5830.7 5631.4 5631.9 5635.5 5651.0 5687.8 5693.2 5751.1 5751.3 5752.7 5812.9 5348.6 5390.1 5396.4 5482.2 5489.7 5609.8 5614.0 5615.4 5624.5 5681.6 5484.0 5488.4 5495.3 5497.0 5498.5 5286.9 5347.8 5452.4 5456.1 5522.9 5453.4 5471.7 5479.4 5520.8 5547.3 5546.6 5555.7 5556.3 5558.7 5562.4 5266.0 5268.2 5318.0 5327.5 5345.1 01:20:15 INFO - PROCESS | 21762 | 01:20:15 INFO - PROCESS | 21762 | [#1] ext.html Cycles:180 Average:57282.14 Median:35311.56 stddev:117468.99 (332.7%) stddev-sans-first:117721.30 01:20:15 INFO - PROCESS | 21762 | Values: 554.5 590.4 622.2 636.1 662.4 31449.8 40496.4 41795.2 41866.0 41880.2 43206.0 43518.3 43680.3 43719.8 43777.6 8032.0 8769.4 8919.2 9043.5 9053.4 8103.6 10525.9 10786.7 10809.6 11192.2 10976.3 11035.9 11050.7 11052.7 11068.2 10830.8 10904.3 10907.5 10907.8 10912.8 10711.1 10718.6 10758.5 10779.9 10787.1 41309.8 41523.8 41619.6 41666.4 41703.2 3575.4 3601.4 3642.6 3854.7 4033.2 31298.7 31534.2 31545.5 31803.5 31848.5 4241.0 4259.6 4524.8 4539.7 4552.7 327121.0 328307.0 328880.0 329022.0 329098.0 32585.3 54477.5 54920.5 54926.5 54936.0 34083.3 35668.0 35760.8 35795.6 35810.8 13562.9 13593.0 13641.5 13695.5 13707.7 10000.5 10224.3 10811.3 11184.7 11258.6 7960.2 7996.8 8127.5 8139.5 8147.7 3214.4 3221.1 3228.3 3263.2 3295.8 990.2 1010.7 1069.3 1112.9 1115.1 29524.0 31681.7 31739.5 31766.2 32274.8 1061.8 1078.7 1082.2 1102.1 1156.8 15748.5 16514.8 16546.2 16593.3 16611.9 556227.0 569761.0 570464.0 572657.0 575220.0 55330.2 55930.4 55952.0 55973.7 56085.7 1204.8 1208.2 1272.1 1325.7 1332.0 30219.4 32716.8 32943.5 33075.7 33256.7 46860.5 47312.0 47346.0 47373.8 47508.8 387217.0 390852.0 391325.0 392214.0 392392.0 26225.6 26571.9 27267.0 27334.5 28366.7 44685.0 44910.6 44913.8 45620.5 46478.8 37745.4 38525.0 38726.0 40029.0 40086.6 37655.8 38255.0 39008.6 39023.8 39549.0 38274.4 38716.8 38725.0 38869.8 39116.6 31417.4 34138.4 34447.1 34782.8 34955.1 25793.4 25982.3 26106.5 26262.7 26442.9 01:20:15 INFO - PROCESS | 21762 | 01:20:15 INFO - PROCESS | 21762 | [#2] jquery.html Cycles:180 Average:27862.19 Median:390.31 stddev:76336.75 (19558.2%) stddev-sans-first:76522.98 01:20:15 INFO - PROCESS | 21762 | Values: 367.4 385.8 388.3 392.4 407.9 14198.2 18262.3 19353.0 19555.2 19736.0 17529.9 19027.8 19145.3 19152.7 19203.5 5493.7 5774.2 5774.6 5776.2 5782.9 4125.7 4289.7 4310.1 5621.3 6326.4 6356.7 6397.3 6399.2 6406.2 6415.5 6152.4 6312.1 6334.8 6343.5 6399.2 5378.8 5598.0 5602.1 5605.6 5606.9 20732.7 21412.5 22301.7 22712.3 22747.2 2172.1 2194.6 2358.5 2433.4 2715.8 9755.4 10332.4 10475.1 10615.0 11328.4 1809.3 1816.8 1846.1 1860.4 1868.4 76742.6 77481.0 77811.6 78889.2 83964.0 10246.2 10402.1 10460.9 10488.6 10653.2 14919.3 14939.8 14942.0 14954.3 14972.3 7312.1 7421.9 7586.3 7652.9 7679.0 7102.9 7109.7 7121.5 7306.4 7322.3 4492.6 4509.1 4539.3 4681.3 4719.6 1928.3 1951.9 1959.2 1960.8 1964.5 834.8 900.5 988.1 1019.9 1035.2 18192.2 18291.9 18848.5 18954.9 18960.5 931.6 940.7 941.8 959.4 964.9 9646.6 10359.4 10469.2 10621.9 10623.7 452055.0 453329.0 461647.0 470852.0 471915.0 87156.6 89914.0 90739.0 91406.5 93646.5 939.6 986.9 1003.4 1010.1 1011.0 15863.6 16359.5 16696.0 16854.5 17176.1 42143.8 42381.6 42655.0 42867.3 42902.4 56127.0 57410.7 57934.0 58978.4 60391.4 7856.0 7967.6 8284.7 8285.3 8349.7 11709.9 12044.6 12261.3 12573.1 12811.6 10657.7 11178.6 11207.8 11373.9 11811.2 10521.0 10862.7 10887.9 10931.2 11130.9 10984.8 11140.3 11195.6 11288.7 11360.4 6948.8 7253.2 7344.8 7910.8 8228.7 10572.7 11468.2 11482.3 11537.2 11566.8 01:20:15 INFO - PROCESS | 21762 | 01:20:15 INFO - PROCESS | 21762 | [#3] mootools.html Cycles:180 Average:5704.21 Median:5213.77 stddev:3244.78 (62.2%) stddev-sans-first:3237.17 01:20:15 INFO - PROCESS | 21762 | Values: 1322.8 1439.5 1484.6 1629.5 1791.7 7527.5 8594.7 8875.2 8880.2 9052.8 8873.4 8946.2 8951.0 8958.9 8966.9 2330.4 2356.7 2359.4 2359.7 2363.5 2226.8 2281.7 2288.9 2305.1 2311.8 2267.4 2284.1 2310.3 2315.0 2317.6 2239.1 2242.9 2257.1 2262.5 2262.8 2254.0 2258.4 2258.8 2263.6 2264.6 8711.8 8812.0 8868.2 8893.0 8895.6 5140.0 5327.0 5337.3 5339.6 5339.7 3186.8 3277.7 3307.2 3314.0 3366.1 1018.0 1029.1 1069.2 1073.3 1078.0 12110.2 12129.3 12226.2 12229.1 12235.7 4264.6 4485.7 4538.0 4549.3 4564.9 9646.5 9649.4 9650.0 9651.7 9654.7 5241.7 5245.6 5248.1 5248.3 5254.7 4312.2 4333.2 4724.9 4747.7 4926.9 3557.2 3678.8 3746.2 3760.7 3785.1 1091.9 1095.9 1108.9 1116.5 1130.0 834.0 936.5 936.9 981.0 1020.8 5895.9 5977.3 5979.3 6056.2 6193.7 895.3 945.2 966.9 975.1 1012.2 4176.0 4263.7 4269.5 4287.6 4296.5 10566.4 10733.7 10824.9 11036.4 11036.4 10969.0 10976.8 10984.8 10987.2 11004.0 7979.4 8298.4 8346.5 8349.6 8366.2 5897.4 5907.1 5983.9 6062.1 6178.9 9835.1 9875.9 9906.3 9947.6 10031.0 9475.0 9771.2 9780.1 9911.1 9947.7 6464.1 6621.4 6651.4 7545.2 7708.0 7567.8 7750.2 8108.8 8185.4 8324.8 7486.0 7656.7 7761.2 7781.7 7880.8 7263.0 7294.7 7313.6 7379.9 7441.0 6922.1 7013.4 7016.8 7020.7 7028.1 4994.2 5112.1 5123.8 5140.7 5385.1 5074.8 5146.7 5213.1 5214.4 5436.4 01:20:15 INFO - PROCESS | 21762 | 01:20:15 INFO - PROCESS | 21762 | [#4] prototype.html Cycles:180 Average:4580.40 Median:5184.07 stddev:1338.40 (25.8%) stddev-sans-first:1303.57 01:20:15 INFO - PROCESS | 21762 | Values: 329.4 332.8 337.4 339.5 345.6 5066.5 5224.3 5237.5 5291.5 5311.8 5087.9 5150.3 5191.0 5214.2 5225.4 4137.3 4144.9 4153.9 4156.4 4159.6 3941.7 4112.7 4170.1 4172.6 4180.0 4088.3 4105.6 4107.7 4107.8 4128.1 4087.8 4092.2 4093.0 4101.8 4121.0 3599.6 3615.0 3619.6 3623.2 3647.6 5124.4 5169.3 5177.1 5199.5 5210.2 4714.5 4744.3 4749.7 4765.2 4765.8 5393.8 5512.3 5516.8 5533.1 5533.3 3821.2 3941.2 3951.7 3952.5 3976.4 5598.6 5628.4 5631.7 5668.3 5685.8 4018.1 4031.5 4055.0 4066.9 4086.2 3898.5 4111.4 4117.5 4125.9 4139.8 4704.0 4708.7 4709.8 4731.5 4746.7 5513.2 5534.5 5585.6 5658.0 5671.0 1306.9 1343.5 1373.9 1390.0 1392.9 883.0 895.3 911.9 918.6 922.8 4616.5 4639.6 4688.4 4689.2 4698.0 4893.7 4897.2 4914.3 4943.4 4968.8 4669.7 4676.5 4689.9 4692.9 4715.4 2762.4 2955.3 2978.0 3017.5 3033.0 5767.7 5812.9 5826.2 5826.4 5859.3 5567.9 5722.8 5727.0 5773.5 5800.2 5676.3 5701.8 5754.4 5757.7 5763.2 5602.7 5621.3 5644.0 5646.3 5674.9 5356.3 5548.3 5561.0 5561.8 5575.7 5718.5 5795.6 5797.4 5805.2 5824.5 4029.7 4148.4 4165.3 4201.7 4230.5 5288.9 5556.5 5581.8 5584.9 5604.7 5283.5 5342.5 5480.8 5515.3 5522.0 5483.6 5511.5 5517.2 5517.2 5527.6 5275.3 5316.8 5366.3 5404.5 5473.3 5469.7 5484.6 5516.7 5536.8 5537.5 5410.4 5413.9 5418.7 5421.3 5452.9 01:20:15 INFO - PROCESS | 21762 | 01:20:15 INFO - PROCESS | 21762 | [#5] yui.html Cycles:180 Average:16345.95 Median:25325.45 stddev:21119.87 (83.4%) stddev-sans-first:21146.57 01:20:15 INFO - PROCESS | 21762 | Values: 731.0 745.4 755.2 786.1 797.1 12581.5 13224.1 13229.3 13333.1 13378.0 13105.0 13135.1 13230.6 13231.1 13237.3 651.9 670.3 773.6 782.7 805.1 792.7 793.3 798.8 799.6 799.7 816.8 825.0 825.2 825.2 826.5 685.7 702.2 830.3 830.5 830.7 601.9 617.5 620.4 623.1 624.6 13367.7 13429.7 13485.1 13538.1 13538.2 11690.7 11853.0 12325.8 12935.5 13328.9 11763.0 11929.2 11942.7 12013.3 12229.5 4337.9 4381.7 4393.1 4395.3 4582.1 62449.0 62953.4 67547.0 68122.3 68271.0 10220.4 10588.5 10672.4 10695.4 10744.4 17878.0 17895.3 17905.1 17910.3 17911.8 7388.3 7566.7 7600.2 7684.1 8007.0 4283.4 4400.6 4489.1 4517.7 4625.9 3260.1 3321.3 3367.9 3368.4 3369.4 644.5 673.1 673.2 691.8 703.9 611.3 637.8 673.3 740.9 752.8 9213.7 9260.5 9330.5 9720.3 9737.4 724.1 724.4 735.6 740.5 751.4 4333.2 4642.9 4654.1 4657.4 4677.4 77130.6 78958.6 79497.0 83293.0 88016.0 45205.5 55025.4 70109.0 71165.6 71283.3 64036.0 64784.0 64865.4 65746.7 66353.7 9093.7 9280.2 9328.2 9338.3 9497.9 45539.5 45941.3 46025.0 47366.0 47870.5 37051.0 38773.0 38844.7 40812.4 40813.8 11018.6 11531.0 11646.3 11860.9 11895.0 13620.9 14004.9 14151.6 14401.9 14498.9 12428.8 12663.5 13301.1 13425.1 13478.7 12470.0 12569.9 13009.3 13220.6 13229.9 12618.4 12726.8 12884.2 13101.0 13162.1 9222.4 9370.9 9566.2 10043.7 10198.3 10662.7 10738.2 10928.9 11040.3 11100.3 01:20:15 INFO - PROCESS | 21762 | -------- Summary: end -------- 01:20:15 INFO - PROCESS | 21762 | 01:20:16 INFO - TEST-INFO | 21762: exit 0 01:20:16 INFO - TEST-OK | dromaeo_css | took 1117708ms 01:20:16 INFO - TEST-START | kraken 01:20:16 INFO - operating with platform_type : linux_ 01:20:16 INFO - Initialising browser for kraken test... 01:20:16 INFO - TEST-INFO | started process 22074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWUKr9Z/profile http://localhost:49795/getInfo.html) 01:20:19 INFO - PROCESS | 22074 | __metrics Screen width/height:1600/1200 01:20:19 INFO - PROCESS | 22074 | colorDepth:24 01:20:19 INFO - PROCESS | 22074 | Browser inner width/height: 1024/697 01:20:19 INFO - PROCESS | 22074 | __metrics 01:20:20 INFO - PROCESS | 22074 | 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" 01:20:20 INFO - PROCESS | 22074 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:20:21 INFO - PROCESS | 22074 | console.error: PushService: 01:20:21 INFO - PROCESS | 22074 | stateChangeProcessEnqueue: Error transitioning state 01:20:21 INFO - PROCESS | 22074 | UnknownError 01:20:22 INFO - TEST-INFO | 22074: exit 0 01:20:22 INFO - Browser initialized. 01:20:22 INFO - Running cycle 1/1 for kraken test... 01:20:22 INFO - TEST-INFO | started process 22155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWUKr9Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:34 INFO - PROCESS | 22155 | RSS: Main: 172355584 01:20:34 INFO - PROCESS | 22155 | 01:20:36 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49795/tests/kraken/driver.html?testName=audio-beat-detection) 01:20:37 INFO - PROCESS | 22155 | RSS: Main: 229027840 01:20:37 INFO - PROCESS | 22155 | 01:20:40 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49795/tests/kraken/driver.html?testName=audio-dft) 01:20:40 INFO - PROCESS | 22155 | RSS: Main: 215543808 01:20:40 INFO - PROCESS | 22155 | 01:20:43 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49795/tests/kraken/driver.html?testName=audio-fft) 01:20:44 INFO - PROCESS | 22155 | RSS: Main: 297340928 01:20:44 INFO - PROCESS | 22155 | 01:20:46 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49795/tests/kraken/driver.html?testName=audio-oscillator) 01:20:47 INFO - PROCESS | 22155 | RSS: Main: 208592896 01:20:47 INFO - PROCESS | 22155 | 01:20:49 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:20:49 INFO - PROCESS | 22155 | RSS: Main: 211136512 01:20:49 INFO - PROCESS | 22155 | 01:20:52 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49795/tests/kraken/driver.html?testName=imaging-darkroom) 01:20:53 INFO - PROCESS | 22155 | RSS: Main: 246751232 01:20:53 INFO - PROCESS | 22155 | 01:20:56 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49795/tests/kraken/driver.html?testName=imaging-desaturate) 01:20:57 INFO - PROCESS | 22155 | RSS: Main: 246751232 01:20:57 INFO - PROCESS | 22155 | 01:21:00 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49795/tests/kraken/driver.html?testName=json-parse-financial) 01:21:00 INFO - PROCESS | 22155 | RSS: Main: 246005760 01:21:00 INFO - PROCESS | 22155 | 01:21:02 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:21:02 INFO - PROCESS | 22155 | RSS: Main: 208285696 01:21:02 INFO - PROCESS | 22155 | 01:21:04 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:21:05 INFO - PROCESS | 22155 | RSS: Main: 216875008 01:21:05 INFO - PROCESS | 22155 | 01:21:07 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:21:07 INFO - PROCESS | 22155 | RSS: Main: 225505280 01:21:07 INFO - PROCESS | 22155 | 01:21:10 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:21:11 INFO - PROCESS | 22155 | RSS: Main: 233197568 01:21:11 INFO - PROCESS | 22155 | 01:21:13 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:21:14 INFO - PROCESS | 22155 | RSS: Main: 231276544 01:21:14 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49795/tests/kraken/driver.html?testName=ai-astar) 01:21:16 INFO - PROCESS | 22155 | RSS: Main: 281808896 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | __start_tp_report 01:21:16 INFO - PROCESS | 22155 | _x_x_mozilla_page_load 01:21:16 INFO - PROCESS | 22155 | _x_x_mozilla_page_load_details 01:21:16 INFO - PROCESS | 22155 | |i|pagename|runs| 01:21:16 INFO - PROCESS | 22155 | |0;ai-astar;102;113;112;111;114;110;111;112;109;110 01:21:16 INFO - PROCESS | 22155 | |1;audio-beat-detection;148;123;128;170;128;123;127;121;155;129 01:21:16 INFO - PROCESS | 22155 | |2;audio-dft;161;159;161;159;167;163;162;162;163;162 01:21:16 INFO - PROCESS | 22155 | |3;audio-fft;75;75;76;128;76;76;75;75;110;77 01:21:16 INFO - PROCESS | 22155 | |4;audio-oscillator;83;81;120;82;83;81;103;81;83;114 01:21:16 INFO - PROCESS | 22155 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 01:21:16 INFO - PROCESS | 22155 | |6;imaging-darkroom;146;145;146;145;146;146;146;146;146;146 01:21:16 INFO - PROCESS | 22155 | |7;imaging-desaturate;84;85;84;85;84;84;84;84;84;85 01:21:16 INFO - PROCESS | 22155 | |8;json-parse-financial;54;51;52;51;53;54;52;53;52;52 01:21:16 INFO - PROCESS | 22155 | |9;json-stringify-tinderbox;62;63;61;61;62;61;62;62;62;61 01:21:16 INFO - PROCESS | 22155 | |10;stanford-crypto-aes;82;87;80;86;79;80;86;80;79;78 01:21:16 INFO - PROCESS | 22155 | |11;stanford-crypto-ccm;141;138;131;135;130;142;131;137;177;127 01:21:16 INFO - PROCESS | 22155 | |12;stanford-crypto-pbkdf2;164;168;169;164;169;170;171;175;170;166 01:21:16 INFO - PROCESS | 22155 | |13;stanford-crypto-sha256-iterative;66;65;66;65;69;67;64;66;66;64 01:21:16 INFO - PROCESS | 22155 | __end_tp_report 01:21:16 INFO - PROCESS | 22155 | __start_cc_report 01:21:16 INFO - PROCESS | 22155 | _x_x_mozilla_cycle_collect,1700 01:21:16 INFO - PROCESS | 22155 | __end_cc_report 01:21:16 INFO - PROCESS | 22155 | __startTimestamp1477470076466__endTimestamp 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | ------- Summary: start ------- 01:21:16 INFO - PROCESS | 22155 | Number of tests: 14 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.31 (3.0%) stddev-sans-first:1.58 01:21:16 INFO - PROCESS | 22155 | Values: 102.0 113.0 112.0 111.0 114.0 110.0 111.0 112.0 109.0 110.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:128.50 stddev:16.59 (12.9%) stddev-sans-first:16.93 01:21:16 INFO - PROCESS | 22155 | Values: 148.0 123.0 128.0 170.0 128.0 123.0 127.0 121.0 155.0 129.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:2.28 (1.4%) stddev-sans-first:2.40 01:21:16 INFO - PROCESS | 22155 | Values: 161.0 159.0 161.0 159.0 167.0 163.0 162.0 162.0 163.0 162.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#3] audio-fft Cycles:10 Average:84.30 Median:75.50 stddev:18.79 (24.9%) stddev-sans-first:19.62 01:21:16 INFO - PROCESS | 22155 | Values: 75.0 75.0 76.0 128.0 76.0 76.0 75.0 75.0 110.0 77.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:81.50 stddev:15.23 (18.7%) stddev-sans-first:15.87 01:21:16 INFO - PROCESS | 22155 | Values: 83.0 81.0 120.0 82.0 83.0 81.0 103.0 81.0 83.0 114.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:21:16 INFO - PROCESS | 22155 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 01:21:16 INFO - PROCESS | 22155 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 01:21:16 INFO - PROCESS | 22155 | Values: 84.0 85.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 85.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:1.07 (2.0%) stddev-sans-first:0.97 01:21:16 INFO - PROCESS | 22155 | Values: 54.0 51.0 52.0 51.0 53.0 54.0 52.0 53.0 52.0 52.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 01:21:16 INFO - PROCESS | 22155 | Values: 62.0 63.0 61.0 61.0 62.0 61.0 62.0 62.0 62.0 61.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:3.37 (4.2%) stddev-sans-first:3.57 01:21:16 INFO - PROCESS | 22155 | Values: 82.0 87.0 80.0 86.0 79.0 80.0 86.0 80.0 79.0 78.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:137.50 stddev:14.26 (10.4%) stddev-sans-first:15.11 01:21:16 INFO - PROCESS | 22155 | Values: 141.0 138.0 131.0 135.0 130.0 142.0 131.0 137.0 177.0 127.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.50 stddev:3.34 (2.0%) stddev-sans-first:3.10 01:21:16 INFO - PROCESS | 22155 | Values: 164.0 168.0 169.0 164.0 169.0 170.0 171.0 175.0 170.0 166.0 01:21:16 INFO - PROCESS | 22155 | 01:21:16 INFO - PROCESS | 22155 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 01:21:16 INFO - PROCESS | 22155 | Values: 66.0 65.0 66.0 65.0 69.0 67.0 64.0 66.0 66.0 64.0 01:21:16 INFO - PROCESS | 22155 | -------- Summary: end -------- 01:21:16 INFO - PROCESS | 22155 | 01:21:17 INFO - TEST-INFO | 22155: exit 0 01:21:17 INFO - TEST-OK | kraken | took 61643ms 01:21:17 INFO - SUITE-END | took 1179s 01:21:18 INFO - Completed test suite (00:19:39) 01:21:18 INFO - javascript benchmark 01:21:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3050.786444948854, 3066.3867226554694, 3080.1221651829233, 3095.9380812383765, 3118.0022392834303, 5147.588192944565, 5191.0656081905245, 5191.117510023296, 5271.604629652777, 5283.0, 5254.7635356408955, 5270.4729527047275, 5285.392179899312, 5287.444818294081, 5291.994521041, 4761.785719642625, 4792.424909010923, 4800.063987522434, 4838.491958344376, 4840.806367745286, 4842.418909730837, 4848.854534363957, 4888.120138375109, 4890.21756518957, 4893.902121957559, 4807.302941073543, 4826.710397376169, 4849.369581954341, 4852.126617208901, 4884.804607815701, 4833.03339332135, 4870.245112007627, 4890.24201248807, 4891.192953162759, 4943.975280123613, 4610.723356598614, 4651.813927442899, 4781.091592597395, 4792.688475249098, 4827.082854257715, 5285.312909321764, 5298.6555873868465, 5299.284596579451, 5314.309139811839, 5365.651232669864, 5614.410486898858, 5669.433056694339, 5676.489115979541, 5678.375378708339, 5757.913631295534, 5534.916976245319, 5540.695261760601, 5559.471850174227, 5564.527015203713, 5718.5711071669375, 5159.819406320836, 5186.273921650972, 5189.221616757516, 5227.085260079471, 5236.083685355085, 5637.295338082739, 5641.069223578145, 5643.0, 5643.7742490299925, 5715.885682286331, 5416.51251387377, 5477.972610136924, 5484.232207490954, 5513.558915286848, 5520.696361700145, 5620.718964051781, 5627.268455100811, 5630.155476678449, 5694.487496125285, 5703.058995265817, 5550.805721799798, 5589.217509548666, 5593.664380137205, 5598.44015598445, 5599.664020158803, 5463.098588732894, 5479.0959491684225, 5519.254900588369, 5544.833654990357, 5657.038303488417, 4301.913961720748, 4323.308270676676, 4351.042770590465, 4363.738175709467, 4364.10535840152, 3838.5777564467885, 3839.5584507781405, 3841.0397400649836, 3872.903177420587, 3879.1271963807917, 5199.610029247821, 5349.679019258857, 5362.168863826113, 5362.785488580413, 5369.006733754268, 5513.228148059275, 5586.944130558642, 5610.102383618601, 5636.098224284095, 5707.486326230659, 5304.9734751326, 5316.308879845596, 5316.973415132899, 5320.255164277004, 5322.042032434121, 4860.246661767432, 4869.123557759637, 4874.46380898101, 4883.4628190898975, 4916.803327866845, 5689.68706721126, 5738.741756620962, 5780.797672081457, 5829.0, 5830.679312637676, 5631.408702086222, 5631.8592035199445, 5635.464630860061, 5651.039323314964, 5687.800926967537, 5693.231413759089, 5751.1085781703905, 5751.281089863767, 5752.71236438168, 5812.912806307824, 5348.572114230775, 5390.083685773507, 5396.379416367011, 5482.17767334903, 5489.725513724218, 5609.775608975595, 5613.971930140323, 5615.410381909841, 5624.493795558255, 5681.630694004876, 5484.0, 5488.396276409512, 5495.258140151029, 5497.038018346693, 5498.505134537911, 5286.867828304323, 5347.759350829144, 5452.427495112956, 5456.127019676833, 5522.944770552243, 5453.372862120907, 5471.72641367938, 5479.397266300624, 5520.7515661796115, 5547.278853748987, 5546.611737178358, 5555.666660000413, 5556.305461817273, 5558.694271814928, 5562.360328562268, 5266.0, 5268.236105764566, 5318.016167009116, 5327.467253274642, 5345.091334473072], "value": 5181.742318897062, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.4704806909402, 590.4272855330329, 622.1787240842089, 636.0745115856427, 662.393909572741, 31449.842750786243, 40496.39255411168, 41795.16409671812, 41865.99999999996, 41880.16239675205, 43206.0, 43518.34722479165, 43680.3447948281, 43719.78140109303, 43777.56222437783, 8032.0, 8769.429987050837, 8919.24186444153, 9043.502607356593, 9053.366264361497, 8103.554304513249, 10525.894741052569, 10786.676399708022, 10809.621663241787, 11192.160587955896, 10976.341419514854, 11035.889641103606, 11050.723731906686, 11052.668419947415, 11068.225224234307, 10830.783384332308, 10904.291221070605, 10907.454627268684, 10907.83638245427, 10912.836307455394, 10711.089557387631, 10718.571257149704, 10758.462076896201, 10779.946100269526, 10787.137029037658, 41309.793451032856, 41523.7923810379, 41619.58380416188, 41666.37500437496, 41703.1659366814, 3575.4279315309686, 3601.423772196436, 3642.5993140754495, 3854.672352850011, 4033.233685599727, 31298.687013129806, 31534.211644708837, 31545.52681709776, 31803.522947155812, 31848.522272165705, 4241.0, 4259.5740425957465, 4524.8190072397065, 4539.72761634303, 4552.726836389827, 327121.0, 328307.0, 328880.0, 329022.0, 329098.0, 32585.348293034007, 54477.45522544803, 54920.45079549153, 54926.45073549293, 54936.0, 34083.318333633186, 35668.0, 35760.821195893855, 35795.64204357975, 35810.8074329226, 13562.864371356358, 13593.0, 13641.522546710818, 13695.452181912611, 13707.725845483035, 10000.499975001221, 10224.284300098921, 10811.297265677706, 11184.720381990353, 11258.605948791754, 7960.164182760843, 7996.800079998046, 8127.471714338549, 8139.511629302261, 8147.674093036212, 3214.3571285742946, 3221.130294820385, 3228.305914228405, 3263.2005158735788, 3295.802251864896, 990.2474119669104, 1010.6765834932897, 1069.2568664777905, 1112.8942750438696, 1115.1246271676857, 29524.0, 31681.683183167872, 31739.52390714141, 31766.205844854063, 32274.83862580719, 1061.8194906865851, 1078.7087486378791, 1082.2370228988702, 1102.1127991966384, 1156.809126494119, 15748.527544173694, 16514.83485165157, 16546.172691365624, 16593.336266549202, 16611.91694041522, 556227.0, 569761.0, 570464.0, 572657.0, 575220.0, 55330.17004744932, 55930.44069559252, 55952.0, 55973.72013139908, 56085.7195714027, 1204.8493938257718, 1208.2206976500108, 1272.1349482352089, 1325.7414804113298, 1331.9667008324675, 30219.395612088076, 32716.83641581777, 32943.50584741279, 33075.66924330726, 33256.667433325354, 46860.53139468562, 47311.999999998625, 47346.0, 47373.763131184125, 47508.76245618888, 387217.0, 390852.0, 391325.0, 392214.0, 392392.0, 26225.606615901157, 26571.867140664173, 27267.0, 27334.48980918126, 28366.716332837233, 44685.0, 44910.55089449194, 44913.77543112264, 45620.54379456163, 46478.76760616175, 37745.433818492194, 38525.0, 38726.0, 40029.0, 40086.599134008284, 37655.811720942314, 38255.0, 39008.609913900495, 39023.80488097541, 39549.0, 38274.425883612326, 38716.80641596774, 38725.0, 38869.80565097156, 39116.6088339113, 31417.371652566362, 34138.43346113501, 34447.13882152966, 34782.82608586941, 34955.12612184614, 25793.355166120997, 25982.28389754251, 26106.477870442865, 26262.73737262603, 26442.86778566095], "value": 18649.783620747192, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.39196629578026, 385.7878167008143, 388.25842640556544, 392.3545767212935, 407.9367698006808, 14198.21909794962, 18262.269509219634, 19353.0, 19555.21779128833, 19736.0, 17529.912350438262, 19027.809721902813, 19145.32991345303, 19152.712709309373, 19203.519912002208, 5493.725313734317, 5774.191613174159, 5774.595778295521, 5776.249087618604, 5782.855428614297, 4125.690573207006, 4289.656827453812, 4310.094880075188, 5621.297337832771, 6326.3989920957665, 6356.745730170787, 6397.26431460381, 6399.168108145935, 6406.199225096863, 6415.454686351665, 6152.415520525543, 6312.116303717483, 6334.80995570129, 6343.524235682342, 6399.200099987502, 5378.784848606051, 5597.972010139923, 5602.13166959122, 5605.5515558755205, 5606.943930560683, 20732.689009664868, 21412.46468838276, 22301.665475017886, 22712.318630441114, 22747.203847865247, 2172.1311475409802, 2194.648856183003, 2358.469344397514, 2433.3673244956262, 2715.823471474348, 9755.414675119515, 10332.431716255604, 10475.057244848, 10614.978183971038, 11328.376939268337, 1809.3082967425498, 1816.8455681267108, 1846.0585101598147, 1860.372174347446, 1868.4394681595602, 76742.6162869182, 77480.99999999943, 77811.61094194549, 78889.21110788875, 83964.0, 10246.180305575535, 10402.11582015522, 10460.947695261628, 10488.580456781796, 10653.201009924132, 14919.25403729831, 14939.775903361458, 14942.0, 14954.327055282321, 14972.326245318987, 7312.085989251344, 7421.851562968711, 7586.317231449196, 7652.923470765332, 7679.0, 7102.857942841218, 7109.680064397011, 7121.501494895411, 7306.415486761046, 7322.304381083789, 4492.640588752892, 4509.098180363941, 4539.341795439643, 4681.297805329228, 4719.5752382285755, 1928.2961718972474, 1951.863369564117, 1959.226105688245, 1960.8039196080279, 1964.4695932098252, 834.7537476444463, 900.5362238447204, 988.0810845913226, 1019.9235057370727, 1035.2494441529982, 18192.181351839197, 18291.90854045748, 18848.528786780167, 18954.90522547406, 18960.525986850163, 931.5901003558548, 940.6801687426171, 941.7928055827707, 959.4003747657714, 964.9337482082339, 9646.565904534313, 10359.378437293786, 10469.162467002621, 10621.946890265499, 10623.734406639742, 452055.0, 453329.0, 461647.0, 470852.0, 471915.0, 87156.56421717851, 89914.0, 90739.0, 91406.54296728474, 93646.53176734073, 939.6241503398695, 986.8815742110993, 1003.433060320931, 1010.1312870930993, 1010.9696709098739, 15863.603409914384, 16359.509214723577, 16696.0, 16854.494365168575, 17176.14119294055, 42143.83921205861, 42381.576184239, 42655.0, 42867.28459869349, 42902.356464653676, 56127.0, 57410.71294643667, 57934.0, 58978.41021589729, 60391.39608603858, 7855.960720196363, 7967.56178410193, 8284.668613255402, 8285.295749861329, 8349.707760228363, 11709.941450292694, 12044.578439754567, 12261.26432414058, 12573.1198816082, 12811.615651530095, 10657.733556661145, 11178.608748694081, 11207.831882521932, 11373.886261137282, 11811.232269902428, 10521.0, 10862.728431789268, 10887.891121088687, 10931.18016148776, 11130.944345278222, 10984.835227471754, 11140.275882067639, 11195.552177912792, 11288.661340159808, 11360.431978401211, 6948.756793512202, 7253.202147763636, 7344.779656610311, 7910.841783164419, 8228.670853165806, 10572.682819515427, 11468.197226194086, 11482.311061336346, 11537.192396532162, 11566.768664626828], "value": 8941.223474541917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.82141910842, 1439.5177615498808, 1484.5546336099167, 1629.535582359028, 1791.6864548703973, 7527.510711803736, 8594.65621375145, 8875.201231889128, 8880.200781929625, 9052.81894362114, 8873.423227490208, 8946.23956963659, 8951.0, 8958.865617015734, 8966.865497017534, 2330.3940975346363, 2356.705411823522, 2359.4219416243045, 2359.6696462495265, 2363.4800343924308, 2226.8218542516643, 2281.7490076091617, 2288.8512246703995, 2305.13557415969, 2311.84972976756, 2267.3764714703425, 2284.1434462076722, 2310.2722642367685, 2315.0392587076344, 2317.606006978809, 2239.1491233331312, 2242.8878556072295, 2257.119723307911, 2262.5180506768093, 2262.751097379287, 2254.0, 2258.4015235962484, 2258.8080013198896, 2263.6265016272296, 2264.6036943534814, 8711.825763484758, 8811.955940220321, 8868.201861832402, 8892.955535222283, 8895.644174233023, 5140.049090918192, 5327.041132596131, 5337.332833395825, 5339.572834173296, 5339.733013349317, 3186.76099292554, 3277.672232776727, 3307.2228026413773, 3313.9834300828584, 3366.0743295593907, 1018.0379541333443, 1029.1046789293289, 1069.2301542889186, 1073.3398959639844, 1077.9730506737317, 12110.212836165621, 12129.332886691229, 12226.20529665569, 12229.143959922809, 12235.69410764729, 4264.616184543406, 4485.663575231805, 4538.047010127844, 4549.294859296814, 4564.863054108382, 9646.517674116267, 9649.372790768577, 9650.034996500433, 9651.71044868655, 9654.71035868925, 5241.711705856214, 5245.606579506552, 5248.134057880483, 5248.343957005374, 5254.684718916801, 4312.159128969884, 4333.1766964276685, 4724.858254252378, 4747.715137091785, 4926.891449423851, 3557.1640664443835, 3678.7976661283888, 3746.157114649182, 3760.680342170946, 3785.1104990327253, 1091.879893211746, 1095.9397233152254, 1108.8558487396588, 1116.4585176189541, 1130.0451118804597, 833.954132522705, 936.5270538378076, 936.9344145909857, 981.043482604455, 1020.7856350166549, 5895.9387310284565, 5977.282726072812, 5979.342272350038, 6056.242969628796, 6193.659348735863, 895.2837729816121, 945.1871390604075, 966.9274804389559, 975.11264749078, 1012.1649639047815, 4175.958240417557, 4263.722858014219, 4269.487661480643, 4287.614114729689, 4296.505901821331, 10566.366018038942, 10733.677989660322, 10824.945875270574, 11036.392998385167, 11036.392998385167, 10969.0, 10976.835347469794, 10984.835227471594, 10987.230893837515, 11004.0, 7979.3616510679, 8298.377621678399, 8346.499210047295, 8349.582520873932, 8366.163383661586, 5897.351291358033, 5907.113932910098, 5983.9401605983385, 6062.060380641008, 6178.876422471435, 9835.065668761456, 9875.901240987785, 9906.25703072258, 9947.552360143665, 10031.0, 9475.0, 9771.169450596779, 9780.119789219005, 9911.058449447291, 9947.701568952943, 6464.0627109069865, 6621.370969757865, 6651.401373876374, 7545.207753185837, 7708.0, 7567.810804729926, 7750.186230445722, 8108.75673729789, 8185.4270201085355, 8324.791880203044, 7485.962570187115, 7656.69373225087, 7761.223877612194, 7781.727639532589, 7880.763577092696, 7262.96368518154, 7294.671739771617, 7313.597752123472, 7379.889301660587, 7441.0, 6922.06552115458, 7013.4038606719005, 7016.789496315118, 7020.684069216795, 7028.121484814398, 4994.225894986283, 5112.130937740519, 5123.769430375716, 5140.742962851918, 5385.138377859524, 5074.7716352764955, 5146.69119852795, 5213.139831927841, 5214.400343960493, 5436.429174936575], "value": 4552.681322609754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.44652982988583, 332.81362437035256, 337.37417091295646, 339.4890689512284, 345.55596059064106, 5066.493350664931, 5224.29472021277, 5237.476252374765, 5291.497307755767, 5311.814086506978, 5087.872803179922, 5150.27896094547, 5191.0, 5214.210397437372, 5225.372955245366, 4137.27597670408, 4144.880882161815, 4153.854615088472, 4156.41810146579, 4159.625633692967, 3941.6649584785328, 4112.732672376301, 4170.061736109382, 4172.600754566137, 4179.979100104495, 4088.2641124597562, 4105.5894410559, 4107.67138628909, 4107.835686572534, 4128.133092050658, 4087.81604827782, 4092.1611069730634, 4092.9590704092875, 4101.753894766323, 4121.0, 3599.6220396858475, 3614.981925090384, 3619.6199399063244, 3623.2391197848483, 3647.58052823926, 5124.4106927703415, 5169.2504586835075, 5177.145770947789, 5199.454057323965, 5210.192420174879, 4714.528547145258, 4744.288356746481, 4749.7387643679585, 4765.237561990065, 4765.833195838129, 5393.7999563656695, 5512.310961129859, 5516.806911758069, 5533.08704063829, 5533.280673512458, 3821.197548514815, 3941.152652179795, 3951.6641085507767, 3952.486176797027, 3976.443297938291, 5598.636088654265, 5628.409017053192, 5631.71841407928, 5668.291463567054, 5685.772569097231, 4018.1361007383553, 4031.496062992126, 4054.9797251014147, 4066.877993660195, 4086.244044851712, 3898.4542164097047, 4111.362738775495, 4117.505899292104, 4125.855595054159, 4139.79301034947, 4703.952960470351, 4708.717476951394, 4709.788059537329, 4731.503192164842, 4746.738929358849, 5513.228148059275, 5534.501894829405, 5585.58108141891, 5657.971710141423, 5671.035923892948, 1306.9085164038427, 1343.4760443427072, 1373.9038267321391, 1390.0, 1392.9442822287197, 882.9911700882909, 895.2748273898034, 911.8814554107923, 918.5958178401482, 922.8338898998111, 4616.538346165424, 4639.582437580567, 4688.413948256468, 4689.226277664216, 4698.02682873194, 4893.681910675795, 4897.240927656219, 4914.287428322873, 4943.3573635427165, 4968.807486203285, 4669.673122881433, 4676.508966558463, 4689.904662922455, 4692.920628255521, 4715.386999690087, 2762.4475104979083, 2955.2611847038243, 2977.9874842553636, 3017.532282496217, 3032.9848350758107, 5767.682777447197, 5812.88374232513, 5826.184334193216, 5826.388229235869, 5859.267591551056, 5567.888642227133, 5722.828315150552, 5726.9713651431475, 5773.480386765212, 5800.216970708984, 5676.262085928803, 5701.800436984686, 5754.360007397955, 5757.740901659352, 5763.184596851978, 5602.663840169603, 5621.269234999424, 5644.0, 5646.265985421869, 5674.914876276942, 5356.303680521507, 5548.306461692288, 5561.02682030635, 5561.805336813192, 5575.721213939206, 5718.485336319751, 5795.609053826967, 5797.362290147996, 5805.187273781758, 5824.504917082096, 4029.7104926423262, 4148.357004664282, 4165.271077561475, 4201.684873634551, 4230.513490948457, 5288.947110528846, 5556.499915007668, 5581.832545023656, 5584.855104703607, 5604.691741954069, 5283.524482796567, 5342.504098852328, 5480.780768769364, 5515.283013208257, 5522.0, 5483.643563168382, 5511.503964643041, 5517.172424136251, 5517.172424136412, 5527.585431092603, 5275.261463395051, 5316.813911513079, 5366.275552800322, 5404.513593776579, 5473.261109750292, 5469.699166545878, 5484.643498172606, 5516.696581688046, 5536.833894983157, 5537.529310008695, 5410.3778065522965, 5413.945860541344, 5418.729063546885, 5421.322334708161, 5452.945470545403], "value": 4154.231391999122, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.0, 745.366438527252, 755.1768572256243, 786.1313248860006, 797.0793733238108, 12581.496740130395, 13224.140430871987, 13229.338533073356, 13333.133346332494, 13378.0, 13105.0, 13135.146215495986, 13230.603081907535, 13231.13997590156, 13237.271950042743, 651.8696260747846, 670.2526682748725, 773.5822655765879, 782.659543098751, 805.1465446626595, 792.7106606088765, 793.2503783924194, 798.7523867601062, 799.588212070784, 799.7200979657132, 816.808050108224, 824.9917500825005, 825.154216927648, 825.1789469477848, 826.499967519651, 685.7051467868814, 702.2415790945767, 830.2983978538126, 830.4975489828627, 830.6511265268601, 601.9277686677583, 617.527591392585, 620.4416025576971, 623.1431781300712, 624.5534442873368, 13367.732645347136, 13429.66425839352, 13485.123466974615, 13538.052336336363, 13538.187708737507, 11690.70773230676, 11853.0, 12325.753484930252, 12935.48258069676, 13328.86671133286, 11763.0, 11929.164958452911, 11942.701432464171, 12013.339266340348, 12229.510819567207, 4337.934930976038, 4381.715188512737, 4393.077453734688, 4395.329774685599, 4582.083583283356, 62449.0, 62953.370466295666, 67547.0, 68122.3187768126, 68271.0, 10220.386776793417, 10588.523516441779, 10672.413017283969, 10695.411752353695, 10744.355338679548, 17878.0, 17895.284188632308, 17905.10474476271, 17910.28358865657, 17911.820881791275, 7388.261173882569, 7566.659500322498, 7600.201978792258, 7684.116326622398, 8006.959965200137, 4283.443152390169, 4400.647948164139, 4489.057297967398, 4517.661175411858, 4625.907481850411, 3260.136063943057, 3321.285923526453, 3367.915802104967, 3368.427367347557, 3369.4440417330866, 644.5005121031238, 673.1417442760519, 673.161913417798, 691.7682576336883, 703.8803403421431, 611.3244864424836, 637.765922939105, 673.2594146438878, 740.9333160015625, 752.7779305105007, 9213.723588292361, 9260.536973151315, 9330.486823224788, 9720.270979676552, 9737.367071140354, 724.1274264511251, 724.3810084461225, 735.5696917303437, 740.4853626729479, 751.443931490693, 4333.155034768253, 4642.86071417858, 4654.13898428785, 4657.417822772153, 4677.391939047902, 77130.6143469279, 78958.6052069736, 79497.0, 83293.0, 88016.0, 45205.547944520134, 55025.44974550283, 70109.0, 71165.64417177984, 71283.28716712767, 64036.0, 64784.0, 64865.35134648593, 65746.67126664336, 66353.66823165854, 9093.681721139728, 9280.211182049332, 9328.160465558132, 9338.346315757832, 9497.905020949978, 45539.54460455353, 45941.31088033749, 46025.0, 47366.0, 47870.52129478661, 37051.0, 38773.0, 38844.688172686685, 40812.38781418222, 40813.795931020155, 11018.614348497764, 11530.979307325197, 11646.301221926711, 11860.924338240946, 11895.048396128115, 13620.93189534046, 14004.859951400764, 14151.64620884486, 14401.927990359982, 14498.85501144975, 12428.75142497127, 12663.493460261487, 13301.135426197266, 13425.127366721132, 13478.73042539124, 12470.0, 12569.874301257236, 13009.284489353176, 13220.603381898558, 13229.933850331072, 12618.36908154607, 12726.809097863354, 12884.162529435556, 13101.0, 13162.14446061003, 9222.40054396462, 9370.859437108313, 9566.234701224024, 10043.748906277402, 10198.277628665632, 10662.73343166427, 10738.248322617343, 10928.945355273172, 11040.33757974524, 11100.333979960906], "value": 6850.576226030847, "unit": "score"}], "name": "dromaeo_css", "value": 6942.446498441658, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 112.0, 111.0, 114.0, 110.0, 111.0, 112.0, 109.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 128.0, 170.0, 128.0, 123.0, 127.0, 121.0, 155.0, 129.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 159.0, 167.0, 163.0, 162.0, 162.0, 163.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 128.0, 76.0, 76.0, 75.0, 75.0, 110.0, 77.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 120.0, 82.0, 83.0, 81.0, 103.0, 81.0, 83.0, 114.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 51.0, 53.0, 54.0, 52.0, 53.0, 52.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 80.0, 86.0, 79.0, 80.0, 86.0, 80.0, 79.0, 78.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 131.0, 135.0, 130.0, 142.0, 131.0, 137.0, 177.0, 127.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 169.0, 164.0, 169.0, 170.0, 171.0, 175.0, 170.0, 166.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 69.0, 67.0, 64.0, 66.0, 66.0, 64.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1498.9999999999998, "alertThreshold": 2.0}]} 01:21:18 INFO - Return code: 0 01:21:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:21:18 INFO - # TBPL SUCCESS # 01:21:18 INFO - Running post-action listener: _resource_record_post_action 01:21:18 INFO - [mozharness: 2016-10-26 08:21:18.283480Z] Finished run-tests step (success) 01:21:18 INFO - Running post-run listener: _resource_record_post_run 01:21:18 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393015296; Read time: 12; Write time: 249040 01:21:18 INFO - TinderboxPrint: CPU usage
13.1% 01:21:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:21:18 INFO - TinderboxPrint: I/O write bytes / time
393,015,296 / 249,040 01:21:18 INFO - TinderboxPrint: CPU idle
8,301.1 (86.9%) 01:21:18 INFO - TinderboxPrint: CPU user
1,200.1 (12.6%) 01:21:18 INFO - TinderboxPrint: Swap in / out
0 / 0 01:21:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103514112; Read time: 0; Write time: 86232 01:21:18 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289120256; Read time: 0; Write time: 162764 01:21:18 INFO - Running post-run listener: _upload_blobber_files 01:21:18 INFO - Blob upload gear active. 01:21:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:21:18 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 01:21:18 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'] 01:21:18 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 01:21:19 INFO - (blobuploader) - INFO - Open directory for files ... 01:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:20 INFO - (blobuploader) - INFO - Done attempting. 01:21:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:21:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:21:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:26 INFO - (blobuploader) - INFO - Done attempting. 01:21:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:21:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:21:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:27 INFO - (blobuploader) - INFO - Done attempting. 01:21:27 INFO - (blobuploader) - INFO - Iteration through files over. 01:21:27 INFO - Return code: 0 01:21:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:21:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:21:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5dd227cf3337f3444280d61e03bdc033c8d49231a1648aa0d6a7d5ba68772a61298eb24638fdc1dab88c4dab40799f8d32d041d69152dd19e14cc16c555a97d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b4767dff4b82d0565c57ca974a5c3c571ce41027f7da7bc8baba0afbdbe5b701e3e3dbc242b783678244240f755ccd4179ec04798a70b595f041916f54a364d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14ef8855d57e3c74c058b39ea5b974ae26ef4db3029b26bc424f17aa78334b80c4b22cd9532484cceabbe47a4d1e9d21b411999ca94e829b350ede933436032c"} 01:21:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:21:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:21:27 INFO - Contents: 01:21:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5dd227cf3337f3444280d61e03bdc033c8d49231a1648aa0d6a7d5ba68772a61298eb24638fdc1dab88c4dab40799f8d32d041d69152dd19e14cc16c555a97d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b4767dff4b82d0565c57ca974a5c3c571ce41027f7da7bc8baba0afbdbe5b701e3e3dbc242b783678244240f755ccd4179ec04798a70b595f041916f54a364d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14ef8855d57e3c74c058b39ea5b974ae26ef4db3029b26bc424f17aa78334b80c4b22cd9532484cceabbe47a4d1e9d21b411999ca94e829b350ede933436032c"} 01:21:27 INFO - Running post-run listener: copy_logs_to_upload_dir 01:21:27 INFO - Copying logs to upload dir... 01:21:27 INFO - mkdir: /builds/slave/test/build/upload/logs 01:21:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.130528 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-26 01:21:27.797139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 01:21:27.800733) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777 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/a5dd227cf3337f3444280d61e03bdc033c8d49231a1648aa0d6a7d5ba68772a61298eb24638fdc1dab88c4dab40799f8d32d041d69152dd19e14cc16c555a97d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b4767dff4b82d0565c57ca974a5c3c571ce41027f7da7bc8baba0afbdbe5b701e3e3dbc242b783678244240f755ccd4179ec04798a70b595f041916f54a364d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14ef8855d57e3c74c058b39ea5b974ae26ef4db3029b26bc424f17aa78334b80c4b22cd9532484cceabbe47a4d1e9d21b411999ca94e829b350ede933436032c"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477456211/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/a5dd227cf3337f3444280d61e03bdc033c8d49231a1648aa0d6a7d5ba68772a61298eb24638fdc1dab88c4dab40799f8d32d041d69152dd19e14cc16c555a97d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b4767dff4b82d0565c57ca974a5c3c571ce41027f7da7bc8baba0afbdbe5b701e3e3dbc242b783678244240f755ccd4179ec04798a70b595f041916f54a364d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14ef8855d57e3c74c058b39ea5b974ae26ef4db3029b26bc424f17aa78334b80c4b22cd9532484cceabbe47a4d1e9d21b411999ca94e829b350ede933436032c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 01:21:27.830944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:21:27.831603) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1477468844.641003-1774835777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:21:27.915196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 01:21:27.916064) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 01:21:27.916772) ========= ========= Total master_lag: 0.19 =========