builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1476686482.81 results: success (0) buildid: 20161016232626 builduid: f4120b61c430419d8b895fa58871b40a revision: 2976adccde9b75596c469428228177ed3d0f0b61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:22.813420) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:22.813957) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:22.814268) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:22.828955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:22.829250) ========= 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=00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-16 23:41:23-- 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% 66.7M=0s 2016-10-16 23:41:23 (66.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117088 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:22.960575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:22.960940) ========= 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=00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015224 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:23.010813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 23:41:23.011205) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2976adccde9b75596c469428228177ed3d0f0b61 --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 2976adccde9b75596c469428228177ed3d0f0b61 --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=00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-16 23:41:23,530 truncating revision to first 12 chars 2016-10-16 23:41:23,530 Setting DEBUG logging. 2016-10-16 23:41:23,531 attempt 1/10 2016-10-16 23:41:23,531 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2976adccde9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-16 23:41:24,525 unpacking tar archive at: fx-team-2976adccde9b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.327156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 23:41:24.352660) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:24.353031) ========= script_repo_revision: 2976adccde9b75596c469428228177ed3d0f0b61 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:24.353470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:24.353785) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:41:24.364588) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-16 23:41:24.365017) ========= /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=00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:41:24 INFO - MultiFileLogger online at 20161016 23:41:24 in /builds/slave/test 23:41:24 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 23:41:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:41:24 INFO - {'append_to_log': False, 23:41:24 INFO - 'base_work_dir': '/builds/slave/test', 23:41:24 INFO - 'blob_upload_branch': 'Fx-Team', 23:41:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:41:24 INFO - 'branch': 'Fx-Team', 23:41:24 INFO - 'buildbot_json_path': 'buildprops.json', 23:41:24 INFO - 'config_files': ('talos/linux_config.py',), 23:41:24 INFO - 'default_actions': ('clobber', 23:41:24 INFO - 'read-buildbot-config', 23:41:24 INFO - 'download-and-extract', 23:41:24 INFO - 'populate-webroot', 23:41:24 INFO - 'create-virtualenv', 23:41:24 INFO - 'install', 23:41:24 INFO - 'run-tests'), 23:41:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:41:24 INFO - 'download_minidump_stackwalk': True, 23:41:24 INFO - 'download_symbols': 'ondemand', 23:41:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:41:24 INFO - 'tooltool.py': '/tools/tooltool.py', 23:41:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:41:24 INFO - '/tools/misc-python/virtualenv.py')}, 23:41:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:41:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:41:24 INFO - 'installer_path': 'installer.exe', 23:41:24 INFO - 'log_level': 'info', 23:41:24 INFO - 'log_name': 'talos', 23:41:24 INFO - 'log_to_console': True, 23:41:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:41:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:41:24 INFO - 'opt_config_files': (), 23:41:24 INFO - 'pip_index': False, 23:41:24 INFO - 'sps_profile': False, 23:41:24 INFO - 'sps_profile_interval': 0, 23:41:24 INFO - 'suite': 'dromaeojs', 23:41:24 INFO - 'system_bits': '32', 23:41:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:41:24 INFO - 'title': 'talos-linux64-ix-016', 23:41:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:41:24 INFO - 'use_talos_json': True, 23:41:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:41:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:41:24 INFO - 'work_dir': 'build'} 23:41:24 INFO - [mozharness: 2016-10-17 06:41:24.985172Z] Running clobber step. 23:41:24 INFO - Running pre-action listener: _resource_record_pre_action 23:41:24 INFO - Running main action method: clobber 23:41:24 INFO - rmtree: /builds/slave/test/build 23:41:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:41:25 INFO - Running post-action listener: _resource_record_post_action 23:41:25 INFO - [mozharness: 2016-10-17 06:41:25.450157Z] Finished clobber step (success) 23:41:25 INFO - [mozharness: 2016-10-17 06:41:25.450258Z] Running read-buildbot-config step. 23:41:25 INFO - Running pre-action listener: _resource_record_pre_action 23:41:25 INFO - Running main action method: read_buildbot_config 23:41:25 INFO - Using buildbot properties: 23:41:25 INFO - { 23:41:25 INFO - "project": "", 23:41:25 INFO - "product": "firefox", 23:41:25 INFO - "script_repo_revision": "production", 23:41:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:41:25 INFO - "repository": "", 23:41:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:41:25 INFO - "buildid": "20161016232626", 23:41:25 INFO - "stage_platform": "linux64-pgo", 23:41:25 INFO - "basedir": "/builds/slave/test", 23:41:25 INFO - "buildnumber": 1636, 23:41:25 INFO - "platform": "ubuntu64_hw", 23:41:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:41:25 INFO - "slavebuilddir": "test", 23:41:25 INFO - "branch": "fx-team", 23:41:25 INFO - "revision": "2976adccde9b75596c469428228177ed3d0f0b61", 23:41:25 INFO - "slavename": "talos-linux64-ix-016", 23:41:25 INFO - "builduid": "f4120b61c430419d8b895fa58871b40a", 23:41:25 INFO - "repo_path": "integration/fx-team" 23:41:25 INFO - } 23:41:25 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:41:25 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 23:41:25 INFO - Running post-action listener: _resource_record_post_action 23:41:25 INFO - [mozharness: 2016-10-17 06:41:25.452621Z] Finished read-buildbot-config step (success) 23:41:25 INFO - [mozharness: 2016-10-17 06:41:25.452709Z] Running download-and-extract step. 23:41:25 INFO - Running pre-action listener: _resource_record_pre_action 23:41:25 INFO - Running main action method: download_and_extract 23:41:25 INFO - mkdir: /builds/slave/test/build/tests 23:41:25 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')]} 23:41:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:41:25 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/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 23:41:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/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 23:41:25 INFO - Downloaded 1361 bytes. 23:41:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:41:25 INFO - Using the following test package requirements: 23:41:25 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:41:25 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:41:25 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:41:25 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:25 INFO - u'jsshell-linux-x86_64.zip'], 23:41:25 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:41:25 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:41:25 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:41:25 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:41:25 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:41:25 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:41:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:41:25 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/1476674090/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:41:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:41:25 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:41:25 INFO - Http code: 200 23:41:25 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 23:41:25 INFO - x-amz-cf-id: -CCRjjNdLc7_Q46Z5FJq3BlZqLEDMI08ir2UPxQWCRio11NIp4WdOg== 23:41:25 INFO - x-amz-replication-status: COMPLETED 23:41:25 INFO - x-amz-version-id: gjKAxzcKI2GShCyVRawZUXy5rcZ4m.3g 23:41:25 INFO - Expected file size: 22100321 23:41:25 INFO - Obtained file size: 22100321 23:41:29 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 23:41:29 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/1476674090/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:41:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:41:29 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:41:29 INFO - Http code: 200 23:41:29 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 23:41:29 INFO - x-amz-cf-id: VXvnrWrA6a2XZ5XH2ORJ_Rk2c29cQn_rqXppvnsGRZnG4sF0VNE64A== 23:41:29 INFO - x-amz-replication-status: COMPLETED 23:41:29 INFO - x-amz-version-id: gjKAxzcKI2GShCyVRawZUXy5rcZ4m.3g 23:41:30 INFO - Expected file size: 22100321 23:41:30 INFO - Obtained file size: 22100321 23:41:34 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/1476674090/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:41:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:41:34 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:41:34 INFO - Http code: 200 23:41:34 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 23:41:34 INFO - x-amz-cf-id: NiXWjJFUP6VnoyQ5pQDbj5HIt0OzGZKz_gShUKAVp96yT3hR-C1A-A== 23:41:34 INFO - x-amz-replication-status: COMPLETED 23:41:34 INFO - x-amz-version-id: RUewfyIzZ5e4hOWOyQtKSu5SN1qnYZsk 23:41:35 INFO - Expected file size: 14409006 23:41:35 INFO - Obtained file size: 14409006 23:41:35 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')]} 23:41:35 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:41:35 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/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 23:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/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 23:41:35 INFO - Downloaded 59721130 bytes. 23:41:35 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:41:35 INFO - mkdir: /builds/slave/test/properties 23:41:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:41:35 INFO - Writing to file /builds/slave/test/properties/build_url 23:41:35 INFO - Contents: 23:41:35 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:41:36 INFO - Running post-action listener: _resource_record_post_action 23:41:36 INFO - Running post-action listener: set_extra_try_arguments 23:41:36 INFO - [mozharness: 2016-10-17 06:41:36.247586Z] Finished download-and-extract step (success) 23:41:36 INFO - [mozharness: 2016-10-17 06:41:36.247816Z] Running populate-webroot step. 23:41:36 INFO - Running pre-action listener: _resource_record_pre_action 23:41:36 INFO - Running main action method: populate_webroot 23:41:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:41:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:41:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:41:36 INFO - '--tppagecycles', 23:41:36 INFO - '7'], 23:41:36 INFO - 'tests': ['tsvgm']}}, 23:41:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:41:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:41:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:41:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:41:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:36 INFO - 'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:41:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:41:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:36 INFO - 'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['damp', 'tps']}, 23:41:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:36 INFO - 'tests': ['damp', 'tps']}, 23:41:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['dromaeo_dom']}, 23:41:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:41:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['basic_compositor_video']}, 23:41:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:41:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['a11yr', 23:41:36 INFO - 'ts_paint', 23:41:36 INFO - 'tpaint', 23:41:36 INFO - 'sessionrestore', 23:41:36 INFO - 'sessionrestore_no_auto_restore', 23:41:36 INFO - 'tabpaint']}, 23:41:36 INFO - 'other-e10s': {'tests': ['a11yr', 23:41:36 INFO - 'ts_paint', 23:41:36 INFO - 'tpaint', 23:41:36 INFO - 'sessionrestore', 23:41:36 INFO - 'sessionrestore_no_auto_restore', 23:41:36 INFO - 'tabpaint']}, 23:41:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:41:36 INFO - 'ts_paint', 23:41:36 INFO - 'tpaint', 23:41:36 INFO - 'sessionrestore', 23:41:36 INFO - 'sessionrestore_no_auto_restore', 23:41:36 INFO - 'tabpaint']}, 23:41:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:41:36 INFO - 'ts_paint', 23:41:36 INFO - 'tpaint', 23:41:36 INFO - 'sessionrestore', 23:41:36 INFO - 'sessionrestore_no_auto_restore', 23:41:36 INFO - 'tabpaint']}, 23:41:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['a11yr', 23:41:36 INFO - 'ts_paint', 23:41:36 INFO - 'tpaint', 23:41:36 INFO - 'sessionrestore', 23:41:36 INFO - 'sessionrestore_no_auto_restore', 23:41:36 INFO - 'tabpaint']}, 23:41:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['a11yr', 23:41:36 INFO - 'ts_paint', 23:41:36 INFO - 'tpaint', 23:41:36 INFO - 'sessionrestore', 23:41:36 INFO - 'sessionrestore_no_auto_restore', 23:41:36 INFO - 'tabpaint']}, 23:41:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['tsvgx', 23:41:36 INFO - 'tsvgr_opacity', 23:41:36 INFO - 'tart', 23:41:36 INFO - 'tscrollx', 23:41:36 INFO - 'cart']}, 23:41:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:41:36 INFO - 'tsvgr_opacity', 23:41:36 INFO - 'tart', 23:41:36 INFO - 'tscrollx', 23:41:36 INFO - 'cart']}, 23:41:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:36 INFO - 'talos_options': ['--disable-e10s'], 23:41:36 INFO - 'tests': ['tp5o']}, 23:41:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:36 INFO - 'tests': ['tp5o']}, 23:41:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:36 INFO - 'talos_options': ['--disable-e10s', 23:41:36 INFO - '--xperf_path', 23:41:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:41:36 INFO - 'tests': ['tp5n']}, 23:41:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:36 INFO - 'talos_options': ['--xperf_path', 23:41:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:41:36 INFO - 'tests': ['tp5n']}}, 23:41:36 INFO - 'talos.zip': {'path': '', 23:41:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:41:36 INFO - Running post-action listener: _resource_record_post_action 23:41:36 INFO - [mozharness: 2016-10-17 06:41:36.264527Z] Finished populate-webroot step (success) 23:41:36 INFO - [mozharness: 2016-10-17 06:41:36.264615Z] Running create-virtualenv step. 23:41:36 INFO - Running pre-action listener: _resource_record_pre_action 23:41:36 INFO - Running main action method: create_virtualenv 23:41:36 INFO - Creating virtualenv /builds/slave/test/build/venv 23:41:36 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 23:41:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:41:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:41:36 INFO - Using real prefix '/usr' 23:41:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:41:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:41:38 INFO - Installing pip.................done. 23:41:38 INFO - Return code: 0 23:41:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:41:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:41:39 INFO - Reading from file tmpfile_stdout 23:41:39 INFO - Output received: 23:41:39 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) 23:41:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:41:39 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')]} 23:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:39 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')]} 23:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:39 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:39 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 23:41:39 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 23:41:39 INFO - Using env: {'DISPLAY': ':0', 23:41:39 INFO - 'HOME': '/home/cltbld', 23:41:39 INFO - 'LANG': 'en_US.UTF-8', 23:41:39 INFO - 'LANGUAGE': 'en_US:en', 23:41:39 INFO - 'LOGNAME': 'cltbld', 23:41:39 INFO - 'MAIL': '/var/mail/cltbld', 23:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:39 INFO - 'MOZ_NO_REMOTE': '1', 23:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:39 INFO - 'NO_EM_RESTART': '1', 23:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:39 INFO - 'PWD': '/builds/slave/test', 23:41:39 INFO - 'SHELL': '/bin/bash', 23:41:39 INFO - 'SHLVL': '1', 23:41:39 INFO - 'TERM': 'linux', 23:41:39 INFO - 'TMOUT': '86400', 23:41:39 INFO - 'USER': 'cltbld', 23:41:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:39 INFO - '_': '/tools/buildbot/bin/python'} 23:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:39 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 23:41:39 INFO - Cleaning up... 23:41:39 INFO - Return code: 0 23:41:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:41:39 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')]} 23:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:39 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')]} 23:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:39 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:39 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 23:41:39 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 23:41:39 INFO - Using env: {'DISPLAY': ':0', 23:41:39 INFO - 'HOME': '/home/cltbld', 23:41:39 INFO - 'LANG': 'en_US.UTF-8', 23:41:39 INFO - 'LANGUAGE': 'en_US:en', 23:41:39 INFO - 'LOGNAME': 'cltbld', 23:41:39 INFO - 'MAIL': '/var/mail/cltbld', 23:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:39 INFO - 'MOZ_NO_REMOTE': '1', 23:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:39 INFO - 'NO_EM_RESTART': '1', 23:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:39 INFO - 'PWD': '/builds/slave/test', 23:41:39 INFO - 'SHELL': '/bin/bash', 23:41:39 INFO - 'SHLVL': '1', 23:41:39 INFO - 'TERM': 'linux', 23:41:39 INFO - 'TMOUT': '86400', 23:41:39 INFO - 'USER': 'cltbld', 23:41:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:39 INFO - '_': '/tools/buildbot/bin/python'} 23:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:39 INFO - Downloading/unpacking psutil>=3.1.1 23:41:39 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 23:41:39 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 23:41:39 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 23:41:39 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 23:41:39 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 23:41:39 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 23:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:41:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:41:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:41:41 INFO - Installing collected packages: psutil 23:41:41 INFO - Running setup.py install for psutil 23:41:41 INFO - building 'psutil._psutil_linux' extension 23:41:41 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 23:41:41 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 23:41:41 INFO - building 'psutil._psutil_posix' extension 23:41:41 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 23:41:41 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 23:41:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:41:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:41:42 INFO - Successfully installed psutil 23:41:42 INFO - Cleaning up... 23:41:42 INFO - Return code: 0 23:41:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:41:42 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')]} 23:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:42 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')]} 23:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:42 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:42 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 23:41:42 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 23:41:42 INFO - Using env: {'DISPLAY': ':0', 23:41:42 INFO - 'HOME': '/home/cltbld', 23:41:42 INFO - 'LANG': 'en_US.UTF-8', 23:41:42 INFO - 'LANGUAGE': 'en_US:en', 23:41:42 INFO - 'LOGNAME': 'cltbld', 23:41:42 INFO - 'MAIL': '/var/mail/cltbld', 23:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:42 INFO - 'MOZ_NO_REMOTE': '1', 23:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:42 INFO - 'NO_EM_RESTART': '1', 23:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:42 INFO - 'PWD': '/builds/slave/test', 23:41:42 INFO - 'SHELL': '/bin/bash', 23:41:42 INFO - 'SHLVL': '1', 23:41:42 INFO - 'TERM': 'linux', 23:41:42 INFO - 'TMOUT': '86400', 23:41:42 INFO - 'USER': 'cltbld', 23:41:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:42 INFO - '_': '/tools/buildbot/bin/python'} 23:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:41:42 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 23:41:42 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 23:41:42 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 23:41:42 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 23:41:42 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 23:41:42 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 23:41:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:41:44 INFO - Installing collected packages: mozsystemmonitor 23:41:44 INFO - Running setup.py install for mozsystemmonitor 23:41:44 INFO - Successfully installed mozsystemmonitor 23:41:44 INFO - Cleaning up... 23:41:44 INFO - Return code: 0 23:41:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:44 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:44 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 23:41:44 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 23:41:44 INFO - Using env: {'DISPLAY': ':0', 23:41:44 INFO - 'HOME': '/home/cltbld', 23:41:44 INFO - 'LANG': 'en_US.UTF-8', 23:41:44 INFO - 'LANGUAGE': 'en_US:en', 23:41:44 INFO - 'LOGNAME': 'cltbld', 23:41:44 INFO - 'MAIL': '/var/mail/cltbld', 23:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:44 INFO - 'MOZ_NO_REMOTE': '1', 23:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:44 INFO - 'NO_EM_RESTART': '1', 23:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:44 INFO - 'PWD': '/builds/slave/test', 23:41:44 INFO - 'SHELL': '/bin/bash', 23:41:44 INFO - 'SHLVL': '1', 23:41:44 INFO - 'TERM': 'linux', 23:41:44 INFO - 'TMOUT': '86400', 23:41:44 INFO - 'USER': 'cltbld', 23:41:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:44 INFO - '_': '/tools/buildbot/bin/python'} 23:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:44 INFO - Downloading/unpacking jsonschema==2.5.1 23:41:44 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 23:41:44 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 23:41:44 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 23:41:44 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 23:41:44 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 23:41:44 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 23:41:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:41:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:41:46 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 23:41:46 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 23:41:46 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 23:41:46 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 23:41:46 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 23:41:46 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 23:41:46 INFO - Downloading functools32-3.2.3-2.tar.gz 23:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:41:46 INFO - warning: no files found matching '*.txt' 23:41:46 INFO - no previously-included directories found matching 'build' 23:41:46 INFO - no previously-included directories found matching 'dist' 23:41:46 INFO - no previously-included directories found matching '.git*' 23:41:46 INFO - Installing collected packages: jsonschema, functools32 23:41:46 INFO - Running setup.py install for functools32 23:41:46 INFO - warning: no files found matching '*.txt' 23:41:46 INFO - no previously-included directories found matching 'build' 23:41:46 INFO - no previously-included directories found matching 'dist' 23:41:46 INFO - no previously-included directories found matching '.git*' 23:41:46 INFO - Successfully installed jsonschema functools32 23:41:46 INFO - Cleaning up... 23:41:47 INFO - Return code: 0 23:41:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:41: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')]} 23:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41: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')]} 23:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:47 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:47 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 23:41:47 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 23:41:47 INFO - Using env: {'DISPLAY': ':0', 23:41:47 INFO - 'HOME': '/home/cltbld', 23:41:47 INFO - 'LANG': 'en_US.UTF-8', 23:41:47 INFO - 'LANGUAGE': 'en_US:en', 23:41:47 INFO - 'LOGNAME': 'cltbld', 23:41:47 INFO - 'MAIL': '/var/mail/cltbld', 23:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:47 INFO - 'MOZ_NO_REMOTE': '1', 23:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:47 INFO - 'NO_EM_RESTART': '1', 23:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:47 INFO - 'PWD': '/builds/slave/test', 23:41:47 INFO - 'SHELL': '/bin/bash', 23:41:47 INFO - 'SHLVL': '1', 23:41:47 INFO - 'TERM': 'linux', 23:41:47 INFO - 'TMOUT': '86400', 23:41:47 INFO - 'USER': 'cltbld', 23:41:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:47 INFO - '_': '/tools/buildbot/bin/python'} 23:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:41:47 INFO - Cleaning up... 23:41:47 INFO - Return code: 0 23:41:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:41: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')]} 23:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41: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')]} 23:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:47 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:47 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 23:41:47 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 23:41:47 INFO - Using env: {'DISPLAY': ':0', 23:41:47 INFO - 'HOME': '/home/cltbld', 23:41:47 INFO - 'LANG': 'en_US.UTF-8', 23:41:47 INFO - 'LANGUAGE': 'en_US:en', 23:41:47 INFO - 'LOGNAME': 'cltbld', 23:41:47 INFO - 'MAIL': '/var/mail/cltbld', 23:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:47 INFO - 'MOZ_NO_REMOTE': '1', 23:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:47 INFO - 'NO_EM_RESTART': '1', 23:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:47 INFO - 'PWD': '/builds/slave/test', 23:41:47 INFO - 'SHELL': '/bin/bash', 23:41:47 INFO - 'SHLVL': '1', 23:41:47 INFO - 'TERM': 'linux', 23:41:47 INFO - 'TMOUT': '86400', 23:41:47 INFO - 'USER': 'cltbld', 23:41:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:47 INFO - '_': '/tools/buildbot/bin/python'} 23:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:47 INFO - Downloading/unpacking blobuploader==1.2.4 23:41:47 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 23:41:47 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 23:41:47 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 23:41:47 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 23:41:47 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 23:41:47 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 23:41:49 INFO - Downloading blobuploader-1.2.4.tar.gz 23:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:41:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:41:49 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 23:41:49 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 23:41:49 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 23:41:49 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 23:41:49 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 23:41:49 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 23:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:41:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:41:49 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 23:41:49 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 23:41:49 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 23:41:49 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 23:41:49 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 23:41:49 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 23:41:50 INFO - Downloading docopt-0.6.1.tar.gz 23:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:41:50 INFO - Installing collected packages: blobuploader, requests, docopt 23:41:50 INFO - Running setup.py install for blobuploader 23:41:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:41:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:41:50 INFO - Running setup.py install for requests 23:41:50 INFO - Running setup.py install for docopt 23:41:50 INFO - Successfully installed blobuploader requests docopt 23:41:50 INFO - Cleaning up... 23:41:50 INFO - Return code: 0 23:41:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:41:50 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')]} 23:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:50 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')]} 23:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:50 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:50 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 23:41:50 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 23:41:50 INFO - Using env: {'DISPLAY': ':0', 23:41:50 INFO - 'HOME': '/home/cltbld', 23:41:50 INFO - 'LANG': 'en_US.UTF-8', 23:41:50 INFO - 'LANGUAGE': 'en_US:en', 23:41:50 INFO - 'LOGNAME': 'cltbld', 23:41:50 INFO - 'MAIL': '/var/mail/cltbld', 23:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:50 INFO - 'MOZ_NO_REMOTE': '1', 23:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:50 INFO - 'NO_EM_RESTART': '1', 23:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:50 INFO - 'PWD': '/builds/slave/test', 23:41:50 INFO - 'SHELL': '/bin/bash', 23:41:50 INFO - 'SHLVL': '1', 23:41:50 INFO - 'TERM': 'linux', 23:41:50 INFO - 'TMOUT': '86400', 23:41:50 INFO - 'USER': 'cltbld', 23:41:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:50 INFO - '_': '/tools/buildbot/bin/python'} 23:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:41:51 INFO - Running setup.py (path:/tmp/pip-Jxj3Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:41:51 INFO - Running setup.py (path:/tmp/pip-ixdbl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:41:51 INFO - Running setup.py (path:/tmp/pip-WjwHSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:41:51 INFO - Running setup.py (path:/tmp/pip-kld_Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:41:51 INFO - Running setup.py (path:/tmp/pip-KrO6AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:41:51 INFO - Running setup.py (path:/tmp/pip-5anFiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:41:51 INFO - Running setup.py (path:/tmp/pip-j7vonh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:41:51 INFO - Running setup.py (path:/tmp/pip-ymKz91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:41:51 INFO - Running setup.py (path:/tmp/pip-Lu5HJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:41:51 INFO - Running setup.py (path:/tmp/pip-S3QHtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:41:51 INFO - Running setup.py (path:/tmp/pip-Zja43b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:41:51 INFO - Running setup.py (path:/tmp/pip-lM6oJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:41:51 INFO - Running setup.py (path:/tmp/pip-EfJaZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:41:51 INFO - Running setup.py (path:/tmp/pip-O4Dx1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:41:52 INFO - Running setup.py (path:/tmp/pip-7y78zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:41:52 INFO - Running setup.py (path:/tmp/pip-tdlSo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:41:52 INFO - Running setup.py (path:/tmp/pip-TnuWwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:41:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:41:52 INFO - Running setup.py install for manifestparser 23:41:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:41:52 INFO - Running setup.py install for mozcrash 23:41:52 INFO - Running setup.py install for mozdebug 23:41:52 INFO - Running setup.py install for mozdevice 23:41:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:41:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:41:52 INFO - Running setup.py install for mozfile 23:41:52 INFO - Running setup.py install for mozhttpd 23:41:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:41:52 INFO - Running setup.py install for mozinfo 23:41:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:41:52 INFO - Running setup.py install for mozInstall 23:41:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Running setup.py install for mozleak 23:41:53 INFO - Running setup.py install for mozlog 23:41:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Running setup.py install for moznetwork 23:41:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Running setup.py install for mozprocess 23:41:53 INFO - Running setup.py install for mozprofile 23:41:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Running setup.py install for mozrunner 23:41:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:41:53 INFO - Running setup.py install for mozscreenshot 23:41:53 INFO - Running setup.py install for moztest 23:41:53 INFO - Running setup.py install for mozversion 23:41:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:41:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:41:54 INFO - Cleaning up... 23:41:54 INFO - Return code: 0 23:41:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:41:54 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')]} 23:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:54 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')]} 23:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:54 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:54 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 23:41:54 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 23:41:54 INFO - Using env: {'DISPLAY': ':0', 23:41:54 INFO - 'HOME': '/home/cltbld', 23:41:54 INFO - 'LANG': 'en_US.UTF-8', 23:41:54 INFO - 'LANGUAGE': 'en_US:en', 23:41:54 INFO - 'LOGNAME': 'cltbld', 23:41:54 INFO - 'MAIL': '/var/mail/cltbld', 23:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:54 INFO - 'MOZ_NO_REMOTE': '1', 23:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:54 INFO - 'NO_EM_RESTART': '1', 23:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:54 INFO - 'PWD': '/builds/slave/test', 23:41:54 INFO - 'SHELL': '/bin/bash', 23:41:54 INFO - 'SHLVL': '1', 23:41:54 INFO - 'TERM': 'linux', 23:41:54 INFO - 'TMOUT': '86400', 23:41:54 INFO - 'USER': 'cltbld', 23:41:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:54 INFO - '_': '/tools/buildbot/bin/python'} 23:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:41:54 INFO - Running setup.py (path:/tmp/pip-x01NuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:41:54 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)) 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:41:54 INFO - Running setup.py (path:/tmp/pip-vEmHiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:41:54 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)) 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:41:54 INFO - Running setup.py (path:/tmp/pip-31cXJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:41:54 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)) 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:41:54 INFO - Running setup.py (path:/tmp/pip-tELB9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:41:54 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)) 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:41:54 INFO - Running setup.py (path:/tmp/pip-XIBcIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:41:54 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)) 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:41:54 INFO - Running setup.py (path:/tmp/pip-If_Ad7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:41:54 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)) 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:41:54 INFO - Running setup.py (path:/tmp/pip-kDVuLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:41:54 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)) 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:41:54 INFO - Running setup.py (path:/tmp/pip-DGrZWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:41:54 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)) 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:41:54 INFO - Running setup.py (path:/tmp/pip-QdaeCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:41:54 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)) 23:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:41:54 INFO - Running setup.py (path:/tmp/pip-tEhMBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:41:55 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)) 23:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:41:55 INFO - Running setup.py (path:/tmp/pip-lGOLUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:41:55 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)) 23:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:41:55 INFO - Running setup.py (path:/tmp/pip-maGWe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:41:55 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)) 23:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:41:55 INFO - Running setup.py (path:/tmp/pip-z_4fsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:41:55 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)) 23:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:41:55 INFO - Running setup.py (path:/tmp/pip-ecCCy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:41:55 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)) 23:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:41:55 INFO - Running setup.py (path:/tmp/pip-vbQS3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:41:55 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)) 23:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:41:55 INFO - Running setup.py (path:/tmp/pip-leZhpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:41:55 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)) 23:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:41:55 INFO - Running setup.py (path:/tmp/pip-wnpiwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:41:55 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)) 23:41:55 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)) 23:41:55 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)) 23:41:55 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)) 23:41:55 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)) 23:41:55 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)) 23:41:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:41:57 INFO - Downloading blessings-1.6.tar.gz 23:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:41:57 INFO - Installing collected packages: blessings 23:41:57 INFO - Running setup.py install for blessings 23:41:57 INFO - Successfully installed blessings 23:41:57 INFO - Cleaning up... 23:41:57 INFO - Return code: 0 23:41:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:41:57 INFO - Reading from file tmpfile_stdout 23:41:57 INFO - Current package versions: 23:41:57 INFO - argparse == 1.2.1 23:41:57 INFO - blessings == 1.6 23:41:57 INFO - blobuploader == 1.2.4 23:41:57 INFO - docopt == 0.6.1 23:41:57 INFO - functools32 == 3.2.3-2 23:41:57 INFO - jsonschema == 2.5.1 23:41:57 INFO - manifestparser == 1.1 23:41:57 INFO - mozInstall == 1.12 23:41:57 INFO - mozcrash == 0.17 23:41:57 INFO - mozdebug == 0.1 23:41:57 INFO - mozdevice == 0.48 23:41:57 INFO - mozfile == 1.2 23:41:57 INFO - mozhttpd == 0.7 23:41:57 INFO - mozinfo == 0.9 23:41:57 INFO - mozleak == 0.1 23:41:57 INFO - mozlog == 3.4 23:41:57 INFO - moznetwork == 0.27 23:41:57 INFO - mozprocess == 0.23 23:41:57 INFO - mozprofile == 0.28 23:41:57 INFO - mozrunner == 6.12 23:41:57 INFO - mozscreenshot == 0.1 23:41:57 INFO - mozsystemmonitor == 0.3 23:41:57 INFO - moztest == 0.7 23:41:57 INFO - mozversion == 1.4 23:41:57 INFO - psutil == 3.1.1 23:41:57 INFO - requests == 1.2.3 23:41:57 INFO - wsgiref == 0.1.2 23:41:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:41: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')]} 23:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41: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')]} 23:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:57 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:57 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 23:41:57 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 23:41:57 INFO - Using env: {'DISPLAY': ':0', 23:41:57 INFO - 'HOME': '/home/cltbld', 23:41:57 INFO - 'LANG': 'en_US.UTF-8', 23:41:57 INFO - 'LANGUAGE': 'en_US:en', 23:41:57 INFO - 'LOGNAME': 'cltbld', 23:41:57 INFO - 'MAIL': '/var/mail/cltbld', 23:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:57 INFO - 'MOZ_NO_REMOTE': '1', 23:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:57 INFO - 'NO_EM_RESTART': '1', 23:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:57 INFO - 'PWD': '/builds/slave/test', 23:41:57 INFO - 'SHELL': '/bin/bash', 23:41:57 INFO - 'SHLVL': '1', 23:41:57 INFO - 'TERM': 'linux', 23:41:57 INFO - 'TMOUT': '86400', 23:41:57 INFO - 'USER': 'cltbld', 23:41:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:57 INFO - '_': '/tools/buildbot/bin/python'} 23:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:58 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)) 23:41:58 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)) 23:41:58 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)) 23:41:58 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)) 23:41:58 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)) 23:41:58 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)) 23:41:58 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)) 23:41:58 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)) 23:41:58 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)) 23:41:58 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)) 23:41:58 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)) 23:41:58 INFO - Cleaning up... 23:41:58 INFO - Return code: 0 23:41:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:41:58 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 0x7f7b80f86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, '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': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', '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 23:41:58 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 23:41:58 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 23:41:58 INFO - Using env: {'DISPLAY': ':0', 23:41:58 INFO - 'HOME': '/home/cltbld', 23:41:58 INFO - 'LANG': 'en_US.UTF-8', 23:41:58 INFO - 'LANGUAGE': 'en_US:en', 23:41:58 INFO - 'LOGNAME': 'cltbld', 23:41:58 INFO - 'MAIL': '/var/mail/cltbld', 23:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:58 INFO - 'MOZ_NO_REMOTE': '1', 23:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:41:58 INFO - 'NO_EM_RESTART': '1', 23:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:58 INFO - 'PWD': '/builds/slave/test', 23:41:58 INFO - 'SHELL': '/bin/bash', 23:41:58 INFO - 'SHLVL': '1', 23:41:58 INFO - 'TERM': 'linux', 23:41:58 INFO - 'TMOUT': '86400', 23:41:58 INFO - 'USER': 'cltbld', 23:41:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:58 INFO - '_': '/tools/buildbot/bin/python'} 23:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:41:58 INFO - Cleaning up... 23:41:58 INFO - Return code: 0 23:41:58 INFO - Running post-action listener: _resource_record_post_action 23:41:58 INFO - Running post-action listener: _start_resource_monitoring 23:41:58 INFO - Starting resource monitoring. 23:41:58 INFO - [mozharness: 2016-10-17 06:41:58.455646Z] Finished create-virtualenv step (success) 23:41:58 INFO - [mozharness: 2016-10-17 06:41:58.456122Z] Running install step. 23:41:58 INFO - Running pre-action listener: _resource_record_pre_action 23:41:58 INFO - Running main action method: install 23:41:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:41:58 INFO - Reading from file tmpfile_stdout 23:41:58 INFO - Detecting whether we're running mozinstall >=1.0... 23:41:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:41:58 INFO - Reading from file tmpfile_stdout 23:41:58 INFO - Output received: 23:41:58 INFO - Usage: mozinstall [options] installer 23:41:58 INFO - Options: 23:41:58 INFO - -h, --help show this help message and exit 23:41:58 INFO - -d DEST, --destination=DEST 23:41:58 INFO - Directory to install application into. [default: 23:41:58 INFO - "/builds/slave/test"] 23:41:58 INFO - --app=APP Application being installed. [default: firefox] 23:41:58 INFO - mkdir: /builds/slave/test/build/application 23:41:58 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'] 23:41:58 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 23:42:15 INFO - Reading from file tmpfile_stdout 23:42:15 INFO - Output received: 23:42:15 INFO - /builds/slave/test/build/application/firefox/firefox 23:42:15 INFO - Running post-action listener: _resource_record_post_action 23:42:15 INFO - [mozharness: 2016-10-17 06:42:15.767999Z] Finished install step (success) 23:42:15 INFO - [mozharness: 2016-10-17 06:42:15.768274Z] Running run-tests step. 23:42:15 INFO - Running pre-action listener: _resource_record_pre_action 23:42:15 INFO - Running main action method: run_tests 23:42:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:42:15 INFO - Python 2.7.3 23:42:15 INFO - Return code: 0 23:42:15 INFO - grabbing minidump binary from tooltool 23:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:15 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 0x2675930>, '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 0x2676830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:42:15 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 23:42:15 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 23:42:15 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 23:42:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:42:15 INFO - Return code: 0 23:42:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:42:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:42:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:42:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:42:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:42:15 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/1476674090/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 23:42:15 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/1476674090/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 23:42:15 INFO - Using env: {'DISPLAY': ':0', 23:42:15 INFO - 'HOME': '/home/cltbld', 23:42:15 INFO - 'LANG': 'en_US.UTF-8', 23:42:15 INFO - 'LANGUAGE': 'en_US:en', 23:42:15 INFO - 'LOGNAME': 'cltbld', 23:42:15 INFO - 'MAIL': '/var/mail/cltbld', 23:42:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:42:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:15 INFO - 'MOZ_NO_REMOTE': '1', 23:42:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:15 INFO - 'NO_EM_RESTART': '1', 23:42:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:15 INFO - 'PWD': '/builds/slave/test', 23:42:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:42:15 INFO - 'SHELL': '/bin/bash', 23:42:15 INFO - 'SHLVL': '1', 23:42:15 INFO - 'TERM': 'linux', 23:42:15 INFO - 'TMOUT': '86400', 23:42:15 INFO - 'USER': 'cltbld', 23:42:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499', 23:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:15 INFO - '_': '/tools/buildbot/bin/python'} 23:42:15 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/1476674090/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 23:42:16 INFO - mozversion application_buildid: 20161016201450 23:42:16 INFO - mozversion application_changeset: 2976adccde9b75596c469428228177ed3d0f0b61 23:42:16 INFO - mozversion application_display_name: Nightly 23:42:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:42:16 INFO - mozversion application_name: Firefox 23:42:16 INFO - mozversion application_remotingname: firefox 23:42:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:42:16 INFO - mozversion application_vendor: Mozilla 23:42:16 INFO - mozversion application_version: 52.0a1 23:42:16 INFO - mozversion platform_buildid: 20161016201450 23:42:16 INFO - mozversion platform_changeset: 2976adccde9b75596c469428228177ed3d0f0b61 23:42:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:42:16 INFO - mozversion platform_version: 52.0a1 23:42:16 INFO - using testdate: 1476686536 23:42:16 INFO - actual date: 1476686536 23:42:16 INFO - starting webserver on 'localhost:60092' 23:42:16 INFO - SUITE-START | Running 2 tests 23:42:16 INFO - TEST-START | dromaeo_css 23:42:16 INFO - operating with platform_type : linux_ 23:42:16 INFO - Initialising browser for dromaeo_css test... 23:42:16 INFO - TEST-INFO | started process 29254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwcEq6t/profile http://localhost:60092/getInfo.html) 23:42:20 INFO - PROCESS | 29254 | __metrics Screen width/height:1600/1200 23:42:20 INFO - PROCESS | 29254 | colorDepth:24 23:42:20 INFO - PROCESS | 29254 | Browser inner width/height: 1024/697 23:42:20 INFO - PROCESS | 29254 | __metrics 23:42:20 INFO - PROCESS | 29254 | 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" 23:42:20 INFO - PROCESS | 29254 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:42:21 INFO - PROCESS | 29254 | console.error: PushService: 23:42:21 INFO - PROCESS | 29254 | stateChangeProcessEnqueue: Error transitioning state 23:42:21 INFO - PROCESS | 29254 | UnknownError 23:42:22 INFO - TEST-INFO | 29254: exit 0 23:42:22 INFO - Browser initialized. 23:42:22 INFO - Running cycle 1/1 for dromaeo_css test... 23:42:22 INFO - TEST-INFO | started process 29338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwcEq6t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:42:34 INFO - PROCESS | 29338 | RSS: Main: 173649920 23:42:34 INFO - PROCESS | 29338 | 23:43:25 INFO - PROCESS | 29338 | 1476686605618 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] 23:45:35 INFO - PROCESS | 29338 | Cycle 1(1): loaded http://localhost:60092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60092/tests/dromaeo/cssquery-ext.html) 23:45:37 INFO - PROCESS | 29338 | RSS: Main: 247787520 23:45:37 INFO - PROCESS | 29338 | 23:48:39 INFO - PROCESS | 29338 | Cycle 1(1): loaded http://localhost:60092/tests/dromaeo/cssquery-ext.html (next: http://localhost:60092/tests/dromaeo/cssquery-jquery.html) 23:48:40 INFO - PROCESS | 29338 | RSS: Main: 278269952 23:48:40 INFO - PROCESS | 29338 | 23:51:42 INFO - PROCESS | 29338 | Cycle 1(1): loaded http://localhost:60092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60092/tests/dromaeo/cssquery-mootools.html) 23:51:42 INFO - PROCESS | 29338 | RSS: Main: 221380608 23:51:42 INFO - PROCESS | 29338 | 23:54:44 INFO - PROCESS | 29338 | Cycle 1(1): loaded http://localhost:60092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60092/tests/dromaeo/cssquery-prototype.html) 23:54:45 INFO - PROCESS | 29338 | RSS: Main: 253829120 23:54:45 INFO - PROCESS | 29338 | 23:57:48 INFO - PROCESS | 29338 | Cycle 1(1): loaded http://localhost:60092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60092/tests/dromaeo/cssquery-yui.html) 23:57:48 INFO - PROCESS | 29338 | RSS: Main: 224272384 23:57:48 INFO - PROCESS | 29338 | 00:00:51 INFO - PROCESS | 29338 | Cycle 1(1): loaded http://localhost:60092/tests/dromaeo/cssquery-yui.html (next: http://localhost:60092/tests/dromaeo/cssquery-dojo.html) 00:00:51 INFO - PROCESS | 29338 | RSS: Main: 316973056 00:00:51 INFO - PROCESS | 29338 | 00:00:51 INFO - PROCESS | 29338 | __start_tp_report 00:00:51 INFO - PROCESS | 29338 | _x_x_mozilla_page_load 00:00:51 INFO - PROCESS | 29338 | _x_x_mozilla_page_load_details 00:00:51 INFO - PROCESS | 29338 | |i|pagename|runs| 00:00:51 INFO - PROCESS | 29338 | |0;dojo.html;2912.4903141950153;2929.414117176565;2939.91180264592;2945.3372991077013;2985.0298652937795;5050.621203409741;5107.719075450848;5115.258287548303;5163.81926632568;5203.318549855575;5117.872053198672;5151.510606492387;5153.922691159635;5184.248283998818;5192.92210616841;4651.860444186663;4695.389599352079;4727.598154156901;4743.715377077369;4774.618030557547;4756.381670382845;4767.90464190716;4777.280144429402;4793.3768610080815;4819.156647586676;4777.665563410563;4790.0898829222515;4798;4837.733924634162;4844.515548445145;4592.540745925414;4611.723296602215;4652.302154676791;4690.7654617269345;4775.594074503671;4682.180618391768;4686.53134686532;4713.5993440557595;4745.501722319142;4766.070616229837;5076.74616269185;5132.204508301182;5133.589312854962;5144.125498665236;5148.819791307286;5334.786608535654;5362.249285100089;5397.595180361489;5479.260299859548;5479.4520547945285;5458.918116228259;5478.835634930959;5489.835304940818;5542.8337149885565;5550.69471179085;5132.435432102466;5138.332016837787;5142.485751424865;5142.845714628567;5217.3999990000875;5497.615166938356;5547.11246200606;5597.412271711493;5602.915956260659;5603.915941260884;5353.598480114007;5370.543503802142;5376.784928602812;5395.622306438511;5460.726963651801;5470.206820011076;5472.20653005312;5475.479829416199;5475.5072043516275;5477.342718873681;5332.146856502941;5393.298871146804;5405.351357837085;5461.472067621054;5524.977879092381;5373.9731301343245;5424.783008679688;5433.755481003364;5443.646162999472;5516.586256030814;4327.112941846914;4330.891727706832;4367.694261401672;4376.890577735582;4377.3433984901885;3819.197968426606;3822.8088595570666;3825.8130967000707;3852.0947577319307;3870.2259548090497;5135.075686376414;5183.974080129575;5275.894482110413;5284.894302113936;5348.304720386325;5399.730013499309;5449.427810079885;5453.127499600045;5500.724963751796;5545.77816887328;5154.639175257696;5199.298094757235;5203.037438073969;5206;5217.452167522356;4611.354410382549;4728.290756386501;4728.739919304402;4746;4770.379850619397;5613.129964855454;5652.830415087554;5723.513501352349;5728.856778580569;5805.419458054161;5525.336959564878;5534.944650553604;5539.861503462284;5541;5541.224228608079;5728.054870946414;5731.828045158652;5734.741936612779;5735.053716136791;5738.053221218619;5305;5319.042572337016;5359.598030147832;5382.892342153214;5437.042664640805;5488.17677348401;5522.30971128609;5525.143602741581;5579.358373786904;5590.5248053915875;5367.543758780547;5381.838544843661;5386.676799392049;5388.811391601275;5393.649412788156;5244.659097158673;5283.920741188962;5348.866278343073;5357.946420535901;5372.167314066326;5403.5136837684795;5436.184572314184;5454.863628409322;5460.2355670207;5464.2076898848645;5262.210668399771;5431.8098866539485;5433.510984011458;5436.646617969819;5438.918416223681;5162.793488260578;5193.532582067632;5202.245674377118;5243.318368612056;5263.868403289948 00:00:51 INFO - PROCESS | 29338 | |1;ext.html;571.1546910572354;582.016392297018;600.4085975314317;600.9218801555799;609.5306613907294;42078;43812.3428148578;43834.12331753363;48105.3920955928;48147.51852481474;43771.34342984858;44164.77917610415;44190.33714494285;44235.3364699529;44249.77875110628;7914.129445760962;8112.647332273663;8954.059823718513;9119.452832830018;9119.544022798867;10562.26064175508;10834.512446939907;10843.51204195809;11201.551937922473;11220.270682405617;10972.615958441456;11049.226554141213;11052.392118433523;11052.557897684082;11056.502457389397;10865.619703310385;10920;10920.617778377718;10921.617743378984;10930.617428390047;10681;10720.08879245265;10726.946365268124;10739.033486986209;10739.24825262232;42339;42603.36094958578;42663.58691304719;42669;42712;3355.328934213143;3433.4506478963244;3437.346904088215;3510.052285882797;3817.8472861085525;31011.224719382197;31093;31216.531752023737;31285.687143128504;31424.528632070538;4325.545817689129;4456.6880318377725;4482.238019536687;4526.932096018562;4555.863324100283;342771;344814;345297;345671;345764;56929.71535142298;57313.42686573164;57326.7133664329;57360.70557177749;57369;60824;61446.385536144066;61816.69091654513;61840;61858;15942.920285398499;16109.19454027294;16129.677406451805;16141;16212.189390530662;11469.426528673534;11703.590374336858;11847.289162650268;12658.367081645882;12716.809247861289;16487.67024659524;16723.331066757437;16755.748663770053;17172.570685732706;17186.398476053277;6228.719707613078;6255.780122876086;6356.68216589178;6463.159789227464;6465.2564955030775;917.6283605139929;1022.8312328465869;1105.380986647464;1109.4840898982013;1125.2179735084037;31689.36621267608;31964.84017579897;32408.35183296368;32720.345593088005;32869.3426131476;1063.7978784031163;1102.4653043274006;1146.8050431426677;1164.1850704506878;1181.4506254591483;16656.250468728937;17070.146492675565;17203.397881074103;17216;17258.741118883227;514374;523516.6483351634;524522;525074;525696;58284.41715582875;58367;58450;58534.12198817021;58579.12131318034;1211.5638370186725;1233.1614502138452;1312.4750099960092;1317.6705823544114;1338.3910320804011;29991.250218744706;33553.49669755004;33687.494687579216;33862.32275354528;33989.66010339865;50841.23738144005;51812.740936296585;51886.740566296925;51920.22119668283;51931.2210316838;396622;396853;398277;399788;401027;26823.731762682124;27536;27914.162575121965;28127;40947;42721.14557708891;47693.28460073171;48053;48158.759206203744;48459;39439;40469.85904228778;40674.796626017865;41029.58970410377;42637.78681106699;40016.79991600024;40638.79680601578;41000.589994099675;41467.58532414637;41529.1694166121;40526.392104119055;40928.590714092476;41033.179336413705;41213.58786412217;42326.576734232265;34310.313793723486;36877.44683829798;37103.62896371002;37198.44202336913;37284.62715372811;27888;28161;28409.28976775597;28469.288267793472;28472 00:00:51 INFO - PROCESS | 29338 | |2;jquery.html;368.43445311446936;394.1820722001847;401.9658329042032;403.87479881236817;421.5236782435847;13713.45146194151;15602.531924042283;18925.905370473163;19009.71485427716;19321.516962075955;18607.534811629717;18768;18907.149178286974;19352.51618709533;19419.805801941977;5438.700871452069;5522.254495643087;5767.36558978512;5771.740271687784;5777.277840269966;5549.805756798512;5578.30271216098;5617.887642247153;5623.775048998035;5633.15502674598;5607;5610.354809196933;5614.438556144373;5645.8588535286535;6168;6387.297397286295;6480.935190648081;6497;6497.057926600663;6497.675116244169;5643.238162848004;5792.68140252286;5821.039528477796;5837.854053648651;5845.532357411439;13596.116252443659;13635.181889086587;13702;18970.81029189718;22515.54968900613;2309.5034567568055;2373.5015646714037;2626.868656567164;2874.9334275716915;2937.529995200779;8984.281257499384;9019.954900225457;9430.339876208669;9753.658621948198;9997.900020999843;1779.74193741908;1861.1996841358211;1876.3339014649875;1902.7050807124917;1919.9520011999812;73456;78637.60681196615;79876;80988.19011809866;82501;10794.298370605886;10880.12958963281;10904.182186336056;10933.453327333602;11320;15514.767278490832;15527.223638818014;15534.844651553565;15544.844551554339;15549.222538873011;7563.508371955805;7835.451518393657;7946.6424010919645;7985.281324680806;8012.439129260896;7297.270272972766;7322;7407.333339999318;7517.17311095779;7523.442029709816;4515.435570553681;4679.9298010529865;4726.669133160645;4843.297721830315;4871.902561948741;1904.6762050451457;1908.9713654295197;1910.8184722451344;1981.2669312354521;1986.8410527157794;848.9395728399155;948.3645957208687;988.3476905242649;1001.409168590535;1019.9898001019894;19098.71351929722;19449.12478938451;19502.414927552196;19570.51073723168;19752.209911603375;950.5294879034922;972.8394814855469;1017.1913328903539;1035.9689209323733;1097.5664612478186;9118.544072796467;10675.733106672395;10882.891171088188;10885.945570272099;10912.345259284468;343114;344306;428392;463849;485261;73581.63209184026;85865.57067214623;90422;92779.08313752992;97205;463.49710564037724;475.0451592299503;477.0482886641173;480.68274938540395;481.0907385042273;10491.160707143563;10768.730781730206;11006.559737610405;11117;11161.33032018049;40352.3947140799;40938;41528.37707434451;41948.58051419569;41970.37044444275;57154.42845571491;57466.13800793075;57859.13211301918;58514.4148558509;58648.120278196715;7989.2809647132035;8225.917740822755;8230.958845205736;8379.078301386964;8530.573471326534;12242.405588017748;13269.270190139636;13333.466661333438;13721;13926.58220253394;11227.326360418401;11437.656870293904;11797.646070617895;11979.940100299442;11998.340091295062;11298.209125361474;11381.886181138083;11433.714157145805;11537.653870383901;12050.09624278165;10857.565697372016;11236.831447528457;11456.140789440658;11763.294202347886;11808.350540720343;8129.390295727726;8279.875801862856;8287.958560207402;8481.194286542768;8503.91496085056;9768.462734549385;10924.2899211551;11243.943780281046;11340.6030788922;11869.5845645402 00:00:51 INFO - PROCESS | 29338 | |3;mootools.html;1374.8006539051844;1485.502356710502;1489.4637930345075;1679.7480377943307;1833.3399976008634;7973.282404583586;8757.080506546816;9073;9081.182693557586;9368.250539956804;9136.451812891215;9195.862062069074;9206.907930920688;9208.309376796751;9209.447433153999;2329.8951547180377;2356.7643235676464;2359.764023597635;2362.9409264768433;2367.8105751539833;2263.875486848223;2283.1894677389537;2348.1429278313462;2353.8234632402555;2356.0340260493203;2325.4186453386656;2332.7667233276707;2344.765523447659;2357.5049239659606;2358.882055897207;2223.377454312779;2251.3020963501285;2255.661650752384;2265.014718597407;2270.7842754938256;2275.943101422461;2312.28319221042;2314.756950520188;2317.2005658047947;2319.675245465636;9043.819123617492;9117.726468205965;9184.8622270666;9195.954020229923;9200.539973001323;5161.251618515332;5383.542398896098;5389.083855744533;5393.4336894626285;5398.595105367113;3606.945895811565;3640.2719456108885;3674.6325367463305;3695.4826324314618;3696.2977034363385;1131.0894729742554;1158.139395692638;1167.4629670351649;1187.8337032815414;1198.6284251881943;12595.874041259562;12791.808122878072;12824.102312838106;12841.807372889414;12854.742905141939;4313.223619748413;4450.599446049806;4601.7699115044115;4614.238650622677;4636.374089497942;10030.097291243823;10047.196224302039;10050.296479246383;10059;10060.0945914868;5212.139996900545;5227.3465816772905;5246.081935661244;5256.526912577886;5256.947430525723;4355.673324500675;4471.61991230749;4580.908381832344;4678.415198100238;4909.87725306863;3566.4472006838982;3584.623614520438;3639.763415377992;3662.8351724172476;3797.9810100949317;1062.6705721226444;1065.5950738719391;1068.4390694885246;1070.5182667799522;1091.1816137896578;910.3854897943861;922.4050487435567;943.1464524605243;950.8716323296405;972.6936015155345;5698.515626171739;5850.3564607893095;5918.556108291896;6146.4468197861515;6177.505799536027;409.040799325581;415.9958400415957;421.50473193997544;423.58911855500116;427.5382586806304;3999.460072890181;4052.8986775330854;4061.3095773718537;4069.5320038195987;4099.590040995936;10745.409002504937;10839.295445795999;11119.722006949729;11174.944125279484;11524.88475115255;11383.203175777782;11444.370559619301;11470.88529114715;11472.942635286938;11487.827682584768;8321.625526851307;8548.871766923377;8641.265492433213;8671.6531338747;8677.435966662148;5871.207387002871;5889.5582831286965;6075.544334175043;6145.938540614716;6263.780767673292;9855.704328870146;10342.276040677081;10375.63685271042;10425.687229383131;10616.84074738864;10334.844977325496;10485.161187105166;10560.313579617301;10652.84020739674;10653.094486968694;7158.425146467769;7317.780466586011;7713.035870516185;7766.8446631065935;7944.165862584346;8660.78348041304;8789.736307910773;8803;8812.91187088121;8827.426217295855;7807;7914.762557123296;8020.598970051591;8127.674893004214;8223.136570660234;7703.268189521987;7749.7675069748;7864.724734634489;7879.212078792075;7890.802729931797;6976.197737260077;7086.681099350439;7092.5389849659605;7094;7097.183823860116;4722.338872557913;4770.570648641639;4852.078105160008;5028.033460258465;5149.510796474329;5222.451642577475;5227.137522308929;5241.921371179359;5293.973530132324;5332.653377530448 00:00:51 INFO - PROCESS | 29338 | |4;prototype.html;309.995350069749;319.55900856817595;322.87730662348304;322.9564008858803;326.81861566830406;4979.626528010395;5156.648178683858;5170.603936937025;5218.660787048844;5246.501582349675;5056.241563765437;5131.230315452684;5136.152534831748;5136.486351364862;5152.768125434355;4072.9592704072875;4074.5517993020744;4087.407325937752;4092.1815636872598;4096.344584866422;3957.4657421248194;4069.837206511736;4111.136661301115;4122.2992091344395;4155.542890282067;4051.4530538377385;4052.878413647595;4054.574269701683;4068.6338229559333;4069.0844559973916;4046.979765101156;4049.3521036634143;4054.493188351456;4056.1887622475474;4062.837486500536;3607.512985746917;3608.3144202601684;3608.3144202601684;3613.1328481164596;3651.233241019389;4867.634927380425;5019.949800502021;5064.898702025939;5070.518300761421;5074.021131758617;4568.977155114237;4574.336721175444;4584.541545845422;4587.977060114678;4623.352730617717;5394.973025134888;5407.621466497347;5409.486098820606;5411.675299482044;5460;3659.579148397915;3835.520559930009;3848.84534639607;3866.8066596670055;3897.512810898638;5513.558915286808;5525;5565;5566.777328906798;5571.331440227158;3930.4104384342004;3948.545917219499;3955.5253369595835;3965.4250133731025;3988.9828093835886;3935.5277366716177;3956.624120708528;3980.144268982183;4033.1328764315813;4037.1320166164414;4528.184926713223;4536.298887917031;4541.909161816745;4547.067851090518;4553.702194874445;5401.918971215435;5420.864478388072;5430.619856610078;5437.8368648940595;5443.401225865152;1302.2251760202664;1315.2043013976597;1334.172812856016;1356.0168877563688;1382.3710211853584;915.1946287267162;929.9256059515222;944.9841420473019;953.6233187890745;958.5734348215117;5207.401148867929;5221.686698798084;5250;5251.921221181686;5255.343082114736;5486.698231597221;5494.2582751328055;5500.944990550123;5509.338879334426;5531.2809334787025;4966.634175601738;5128.512791284822;5209.463208353544;5233.345831771028;5234.581233501311;2513.7611926866916;2546.681664791901;2547.2805856047094;2568.845869247814;2577.4071963448514;4952.430470495867;4967.875803104879;4978.701277923336;4997.375852847839;5026.949730502648;4642.025174713348;4857.231378114511;4903.37150508621;4914.70511769295;4936.925946110811;4953.578945789504;4958.529029679239;4961.702297862068;4972.229304457815;4977.303177555145;4774.379330686988;4831.130396528518;4837.346958160744;4840.273958906192;4884.096442158212;4567.38340324052;4713.373886009322;4769.902922327815;4786.497417771223;4788.61691064721;5024.5679981205185;5033.062271025608;5033.546980771748;5044.225675878326;5050.040492306597;3550.5206797083097;3578.982105089458;3581.767185132958;3600.801955892451;3601.85592576294;4660.159237101394;4781.976090119527;4876.463589005278;4887.780049897692;4935.876603084808;4656.720596764205;4656.743879086683;4662.836800712094;4684.789184486638;4749.4063242094735;4662.2307319293295;4696.835610753607;4700.318453824245;4714.787834547385;4737.786799593958;4391.429114215131;4627.051454451762;4659.088069956278;4665.183592871302;4679.251319788817;4678.60231880294;4686.687727436323;4701.89505466222;4713.410823647044;4715.646326525456;4616.737798478788;4629.236176030917;4651.186032450454;4670.789814458425;4721.527847215389 00:00:51 INFO - PROCESS | 29338 | |5;yui.html;726.4007194064897;827.2513375395266;827.9917200827994;828.246295870757;828.8710119299647;15799.84200157998;16825.83174168258;16834.410795622156;16846;16864.40974565889;14793.482228122019;14885.255737213123;14887.330070146842;14894.329755161016;14911.850881491182;655.9868802623945;659.2188256915571;781.1173374087274;794.5232860283842;813.6785969542027;809.0655293136407;814.0760237130839;822.6503735912244;822.880682301066;823.189158678701;855.482433127958;862.021605477781;863.5725315968605;863.8445079885618;864.7535452396069;679.3715812873122;692.7609974558819;856.7344123321759;859.2953777902092;859.497194141428;610.6671863834221;615.1510914937357;624.687656171914;631.4411745605126;632.1592282264577;15008.849911500854;15013.924930375388;15028;15031.549053528412;15032.774508382383;13458.798118028237;13782.724345513134;13956.302184890816;14050.92974535131;14097.577072687836;12967.157134786208;13078.881415368183;13144.6713832154;13175.868241317656;13407.455853499026;4312.568743125694;4329.328954012133;4367.148406060819;4393.5606439356125;4410.206162890679;78396.60801695955;78697.21302786955;79314;80358.59820700917;82921.17078829255;11151.944240278908;11154.609588664358;11187.384693841754;11270.21108522412;11278.943605282086;21919;21923.78076219249;21962.560748784934;22097.55804883893;22111.336659899905;8222.62998165084;8310.916890831015;8373.539455330016;8398.958005210057;8419.747407577783;4406.140802543473;4442.6890117691455;4562.543745625478;4694.29984964348;4699.976500117477;3466;3569.23261498779;3578.3916734155255;3578.4453409721536;3581.122624956902;606.7178761875749;608.9147519347295;618.7679620142446;619.1672200889795;620.1163342237294;569.0354848531699;578.9218455508536;613.2640831002815;684.7945616315086;723.1394640377933;9668.574153552716;9823.852642210373;10059.69820905374;10126.139278161292;10466.790664186674;631.2046821005474;669.7421492725335;683.4634811672813;702.1223470661673;725.0067407651446;4623.260278355514;4811.106235289458;4856.95143048572;4880.633952453581;4908.239222920453;71224.2877571228;97944;122867;125785.37107314589;131214;98084.50957745165;98226;99125.50437247768;107330;110308;58732;66669.66665166643;91661.54169229245;94755.99999999862;95716;8878.689245876363;9070.818583628423;9089.545522723705;9097.49963752;9162.221211197122;38103.756708407294;42507.3623895648;51169;52924.735376322875;54726.179107314216;69851.65074174597;69971;72023;72038.63980680062;73070.63464682642;13190.934045329712;13210.405531751287;13259.933700331823;13263.867361326264;13802.930985345009;14714.55856324312;14879.941850334415;14973.475928342456;15026.624334391729;15417.306221220297;13905.791413129013;14120.717585648024;14574.34415451286;14583.343749531508;14697.338619761922;12684.619461416172;12941.28822914711;13132.73734525285;13483.19100853952;13780.586582402544;11862.347570883685;12504;12611.87388126107;13470.73058538804;14990.100593964396;10763.838542421714;11325.603663406859;11593;12085.274883506667;12229.633111006684;11394.37330946806;11540.480678369326;11701.122415819018;12038.277703337828;12084.335361554848 00:00:51 INFO - PROCESS | 29338 | __end_tp_report 00:00:51 INFO - PROCESS | 29338 | __start_cc_report 00:00:51 INFO - PROCESS | 29338 | _x_x_mozilla_cycle_collect,1461 00:00:51 INFO - PROCESS | 29338 | __end_cc_report 00:00:51 INFO - PROCESS | 29338 | __startTimestamp1476687651903__endTimestamp 00:00:51 INFO - PROCESS | 29338 | 00:00:51 INFO - PROCESS | 29338 | ------- Summary: start ------- 00:00:51 INFO - PROCESS | 29338 | Number of tests: 6 00:00:51 INFO - PROCESS | 29338 | 00:00:51 INFO - PROCESS | 29338 | [#0] dojo.html Cycles:165 Average:5117.61 Median:5305.00 stddev:561.26 (10.6%) stddev-sans-first:535.66 00:00:51 INFO - PROCESS | 29338 | Values: 2912.5 2929.4 2939.9 2945.3 2985.0 5050.6 5107.7 5115.3 5163.8 5203.3 5117.9 5151.5 5153.9 5184.2 5192.9 4651.9 4695.4 4727.6 4743.7 4774.6 4756.4 4767.9 4777.3 4793.4 4819.2 4777.7 4790.1 4798.0 4837.7 4844.5 4592.5 4611.7 4652.3 4690.8 4775.6 4682.2 4686.5 4713.6 4745.5 4766.1 5076.7 5132.2 5133.6 5144.1 5148.8 5334.8 5362.2 5397.6 5479.3 5479.5 5458.9 5478.8 5489.8 5542.8 5550.7 5132.4 5138.3 5142.5 5142.8 5217.4 5497.6 5547.1 5597.4 5602.9 5603.9 5353.6 5370.5 5376.8 5395.6 5460.7 5470.2 5472.2 5475.5 5475.5 5477.3 5332.1 5393.3 5405.4 5461.5 5525.0 5374.0 5424.8 5433.8 5443.6 5516.6 4327.1 4330.9 4367.7 4376.9 4377.3 3819.2 3822.8 3825.8 3852.1 3870.2 5135.1 5184.0 5275.9 5284.9 5348.3 5399.7 5449.4 5453.1 5500.7 5545.8 5154.6 5199.3 5203.0 5206.0 5217.5 4611.4 4728.3 4728.7 4746.0 4770.4 5613.1 5652.8 5723.5 5728.9 5805.4 5525.3 5534.9 5539.9 5541.0 5541.2 5728.1 5731.8 5734.7 5735.1 5738.1 5305.0 5319.0 5359.6 5382.9 5437.0 5488.2 5522.3 5525.1 5579.4 5590.5 5367.5 5381.8 5386.7 5388.8 5393.6 5244.7 5283.9 5348.9 5357.9 5372.2 5403.5 5436.2 5454.9 5460.2 5464.2 5262.2 5431.8 5433.5 5436.6 5438.9 5162.8 5193.5 5202.2 5243.3 5263.9 00:00:51 INFO - PROCESS | 29338 | 00:00:51 INFO - PROCESS | 29338 | [#1] ext.html Cycles:180 Average:58925.11 Median:37241.53 stddev:113347.17 (304.4%) stddev-sans-first:113580.46 00:00:51 INFO - PROCESS | 29338 | Values: 571.2 582.0 600.4 600.9 609.5 42078.0 43812.3 43834.1 48105.4 48147.5 43771.3 44164.8 44190.3 44235.3 44249.8 7914.1 8112.6 8954.1 9119.5 9119.5 10562.3 10834.5 10843.5 11201.6 11220.3 10972.6 11049.2 11052.4 11052.6 11056.5 10865.6 10920.0 10920.6 10921.6 10930.6 10681.0 10720.1 10726.9 10739.0 10739.2 42339.0 42603.4 42663.6 42669.0 42712.0 3355.3 3433.5 3437.3 3510.1 3817.8 31011.2 31093.0 31216.5 31285.7 31424.5 4325.5 4456.7 4482.2 4526.9 4555.9 342771.0 344814.0 345297.0 345671.0 345764.0 56929.7 57313.4 57326.7 57360.7 57369.0 60824.0 61446.4 61816.7 61840.0 61858.0 15942.9 16109.2 16129.7 16141.0 16212.2 11469.4 11703.6 11847.3 12658.4 12716.8 16487.7 16723.3 16755.7 17172.6 17186.4 6228.7 6255.8 6356.7 6463.2 6465.3 917.6 1022.8 1105.4 1109.5 1125.2 31689.4 31964.8 32408.4 32720.3 32869.3 1063.8 1102.5 1146.8 1164.2 1181.5 16656.3 17070.1 17203.4 17216.0 17258.7 514374.0 523516.6 524522.0 525074.0 525696.0 58284.4 58367.0 58450.0 58534.1 58579.1 1211.6 1233.2 1312.5 1317.7 1338.4 29991.3 33553.5 33687.5 33862.3 33989.7 50841.2 51812.7 51886.7 51920.2 51931.2 396622.0 396853.0 398277.0 399788.0 401027.0 26823.7 27536.0 27914.2 28127.0 40947.0 42721.1 47693.3 48053.0 48158.8 48459.0 39439.0 40469.9 40674.8 41029.6 42637.8 40016.8 40638.8 41000.6 41467.6 41529.2 40526.4 40928.6 41033.2 41213.6 42326.6 34310.3 36877.4 37103.6 37198.4 37284.6 27888.0 28161.0 28409.3 28469.3 28472.0 00:00:51 INFO - PROCESS | 29338 | 00:00:51 INFO - PROCESS | 29338 | [#2] jquery.html Cycles:180 Average:26196.47 Median:41233.19 stddev:69252.22 (168.0%) stddev-sans-first:69419.34 00:00:51 INFO - PROCESS | 29338 | Values: 368.4 394.2 402.0 403.9 421.5 13713.5 15602.5 18925.9 19009.7 19321.5 18607.5 18768.0 18907.1 19352.5 19419.8 5438.7 5522.3 5767.4 5771.7 5777.3 5549.8 5578.3 5617.9 5623.8 5633.2 5607.0 5610.4 5614.4 5645.9 6168.0 6387.3 6480.9 6497.0 6497.1 6497.7 5643.2 5792.7 5821.0 5837.9 5845.5 13596.1 13635.2 13702.0 18970.8 22515.5 2309.5 2373.5 2626.9 2874.9 2937.5 8984.3 9020.0 9430.3 9753.7 9997.9 1779.7 1861.2 1876.3 1902.7 1920.0 73456.0 78637.6 79876.0 80988.2 82501.0 10794.3 10880.1 10904.2 10933.5 11320.0 15514.8 15527.2 15534.8 15544.8 15549.2 7563.5 7835.5 7946.6 7985.3 8012.4 7297.3 7322.0 7407.3 7517.2 7523.4 4515.4 4679.9 4726.7 4843.3 4871.9 1904.7 1909.0 1910.8 1981.3 1986.8 848.9 948.4 988.3 1001.4 1020.0 19098.7 19449.1 19502.4 19570.5 19752.2 950.5 972.8 1017.2 1036.0 1097.6 9118.5 10675.7 10882.9 10885.9 10912.3 343114.0 344306.0 428392.0 463849.0 485261.0 73581.6 85865.6 90422.0 92779.1 97205.0 463.5 475.0 477.0 480.7 481.1 10491.2 10768.7 11006.6 11117.0 11161.3 40352.4 40938.0 41528.4 41948.6 41970.4 57154.4 57466.1 57859.1 58514.4 58648.1 7989.3 8225.9 8231.0 8379.1 8530.6 12242.4 13269.3 13333.5 13721.0 13926.6 11227.3 11437.7 11797.6 11979.9 11998.3 11298.2 11381.9 11433.7 11537.7 12050.1 10857.6 11236.8 11456.1 11763.3 11808.4 8129.4 8279.9 8288.0 8481.2 8503.9 9768.5 10924.3 11243.9 11340.6 11869.6 00:00:51 INFO - PROCESS | 29338 | 00:00:51 INFO - PROCESS | 29338 | [#3] mootools.html Cycles:180 Average:5868.27 Median:4403.14 stddev:3442.94 (78.2%) stddev-sans-first:3436.04 00:00:51 INFO - PROCESS | 29338 | Values: 1374.8 1485.5 1489.5 1679.7 1833.3 7973.3 8757.1 9073.0 9081.2 9368.3 9136.5 9195.9 9206.9 9208.3 9209.4 2329.9 2356.8 2359.8 2362.9 2367.8 2263.9 2283.2 2348.1 2353.8 2356.0 2325.4 2332.8 2344.8 2357.5 2358.9 2223.4 2251.3 2255.7 2265.0 2270.8 2275.9 2312.3 2314.8 2317.2 2319.7 9043.8 9117.7 9184.9 9196.0 9200.5 5161.3 5383.5 5389.1 5393.4 5398.6 3606.9 3640.3 3674.6 3695.5 3696.3 1131.1 1158.1 1167.5 1187.8 1198.6 12595.9 12791.8 12824.1 12841.8 12854.7 4313.2 4450.6 4601.8 4614.2 4636.4 10030.1 10047.2 10050.3 10059.0 10060.1 5212.1 5227.3 5246.1 5256.5 5256.9 4355.7 4471.6 4580.9 4678.4 4909.9 3566.4 3584.6 3639.8 3662.8 3798.0 1062.7 1065.6 1068.4 1070.5 1091.2 910.4 922.4 943.1 950.9 972.7 5698.5 5850.4 5918.6 6146.4 6177.5 409.0 416.0 421.5 423.6 427.5 3999.5 4052.9 4061.3 4069.5 4099.6 10745.4 10839.3 11119.7 11174.9 11524.9 11383.2 11444.4 11470.9 11472.9 11487.8 8321.6 8548.9 8641.3 8671.7 8677.4 5871.2 5889.6 6075.5 6145.9 6263.8 9855.7 10342.3 10375.6 10425.7 10616.8 10334.8 10485.2 10560.3 10652.8 10653.1 7158.4 7317.8 7713.0 7766.8 7944.2 8660.8 8789.7 8803.0 8812.9 8827.4 7807.0 7914.8 8020.6 8127.7 8223.1 7703.3 7749.8 7864.7 7879.2 7890.8 6976.2 7086.7 7092.5 7094.0 7097.2 4722.3 4770.6 4852.1 5028.0 5149.5 5222.5 5227.1 5241.9 5294.0 5332.7 00:00:51 INFO - PROCESS | 29338 | 00:00:51 INFO - PROCESS | 29338 | [#4] prototype.html Cycles:180 Average:4296.77 Median:4701.11 stddev:1217.55 (25.9%) stddev-sans-first:1183.62 00:00:51 INFO - PROCESS | 29338 | Values: 310.0 319.6 322.9 323.0 326.8 4979.6 5156.6 5170.6 5218.7 5246.5 5056.2 5131.2 5136.2 5136.5 5152.8 4073.0 4074.6 4087.4 4092.2 4096.3 3957.5 4069.8 4111.1 4122.3 4155.5 4051.5 4052.9 4054.6 4068.6 4069.1 4047.0 4049.4 4054.5 4056.2 4062.8 3607.5 3608.3 3608.3 3613.1 3651.2 4867.6 5019.9 5064.9 5070.5 5074.0 4569.0 4574.3 4584.5 4588.0 4623.4 5395.0 5407.6 5409.5 5411.7 5460.0 3659.6 3835.5 3848.8 3866.8 3897.5 5513.6 5525.0 5565.0 5566.8 5571.3 3930.4 3948.5 3955.5 3965.4 3989.0 3935.5 3956.6 3980.1 4033.1 4037.1 4528.2 4536.3 4541.9 4547.1 4553.7 5401.9 5420.9 5430.6 5437.8 5443.4 1302.2 1315.2 1334.2 1356.0 1382.4 915.2 929.9 945.0 953.6 958.6 5207.4 5221.7 5250.0 5251.9 5255.3 5486.7 5494.3 5500.9 5509.3 5531.3 4966.6 5128.5 5209.5 5233.3 5234.6 2513.8 2546.7 2547.3 2568.8 2577.4 4952.4 4967.9 4978.7 4997.4 5026.9 4642.0 4857.2 4903.4 4914.7 4936.9 4953.6 4958.5 4961.7 4972.2 4977.3 4774.4 4831.1 4837.3 4840.3 4884.1 4567.4 4713.4 4769.9 4786.5 4788.6 5024.6 5033.1 5033.5 5044.2 5050.0 3550.5 3579.0 3581.8 3600.8 3601.9 4660.2 4782.0 4876.5 4887.8 4935.9 4656.7 4656.7 4662.8 4684.8 4749.4 4662.2 4696.8 4700.3 4714.8 4737.8 4391.4 4627.1 4659.1 4665.2 4679.3 4678.6 4686.7 4701.9 4713.4 4715.6 4616.7 4629.2 4651.2 4670.8 4721.5 00:00:51 INFO - PROCESS | 29338 | 00:00:51 INFO - PROCESS | 29338 | [#5] yui.html Cycles:180 Average:20654.97 Median:4426.45 stddev:29772.43 (672.6%) stddev-sans-first:29818.35 00:00:51 INFO - PROCESS | 29338 | Values: 726.4 827.3 828.0 828.2 828.9 15799.8 16825.8 16834.4 16846.0 16864.4 14793.5 14885.3 14887.3 14894.3 14911.9 656.0 659.2 781.1 794.5 813.7 809.1 814.1 822.7 822.9 823.2 855.5 862.0 863.6 863.8 864.8 679.4 692.8 856.7 859.3 859.5 610.7 615.2 624.7 631.4 632.2 15008.8 15013.9 15028.0 15031.5 15032.8 13458.8 13782.7 13956.3 14050.9 14097.6 12967.2 13078.9 13144.7 13175.9 13407.5 4312.6 4329.3 4367.1 4393.6 4410.2 78396.6 78697.2 79314.0 80358.6 82921.2 11151.9 11154.6 11187.4 11270.2 11278.9 21919.0 21923.8 21962.6 22097.6 22111.3 8222.6 8310.9 8373.5 8399.0 8419.7 4406.1 4442.7 4562.5 4694.3 4700.0 3466.0 3569.2 3578.4 3578.4 3581.1 606.7 608.9 618.8 619.2 620.1 569.0 578.9 613.3 684.8 723.1 9668.6 9823.9 10059.7 10126.1 10466.8 631.2 669.7 683.5 702.1 725.0 4623.3 4811.1 4857.0 4880.6 4908.2 71224.3 97944.0 122867.0 125785.4 131214.0 98084.5 98226.0 99125.5 107330.0 110308.0 58732.0 66669.7 91661.5 94756.0 95716.0 8878.7 9070.8 9089.5 9097.5 9162.2 38103.8 42507.4 51169.0 52924.7 54726.2 69851.7 69971.0 72023.0 72038.6 73070.6 13190.9 13210.4 13259.9 13263.9 13802.9 14714.6 14879.9 14973.5 15026.6 15417.3 13905.8 14120.7 14574.3 14583.3 14697.3 12684.6 12941.3 13132.7 13483.2 13780.6 11862.3 12504.0 12611.9 13470.7 14990.1 10763.8 11325.6 11593.0 12085.3 12229.6 11394.4 11540.5 11701.1 12038.3 12084.3 00:00:51 INFO - PROCESS | 29338 | -------- Summary: end -------- 00:00:51 INFO - PROCESS | 29338 | 00:00:52 INFO - TEST-INFO | 29338: exit 0 00:00:52 INFO - TEST-OK | dromaeo_css | took 1116860ms 00:00:52 INFO - TEST-START | kraken 00:00:52 INFO - operating with platform_type : linux_ 00:00:52 INFO - Initialising browser for kraken test... 00:00:52 INFO - TEST-INFO | started process 29645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6WCKB2/profile http://localhost:60092/getInfo.html) 00:00:57 INFO - PROCESS | 29645 | __metrics Screen width/height:1600/1200 00:00:57 INFO - PROCESS | 29645 | colorDepth:24 00:00:57 INFO - PROCESS | 29645 | Browser inner width/height: 1024/697 00:00:57 INFO - PROCESS | 29645 | __metrics 00:00:57 INFO - PROCESS | 29645 | 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" 00:00:57 INFO - PROCESS | 29645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:00:58 INFO - PROCESS | 29645 | console.error: PushService: 00:00:58 INFO - PROCESS | 29645 | stateChangeProcessEnqueue: Error transitioning state 00:00:58 INFO - PROCESS | 29645 | UnknownError 00:00:59 INFO - TEST-INFO | 29645: exit 0 00:00:59 INFO - Browser initialized. 00:00:59 INFO - Running cycle 1/1 for kraken test... 00:00:59 INFO - TEST-INFO | started process 29730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6WCKB2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:01:11 INFO - PROCESS | 29730 | RSS: Main: 172679168 00:01:11 INFO - PROCESS | 29730 | 00:01:13 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60092/tests/kraken/driver.html?testName=audio-beat-detection) 00:01:14 INFO - PROCESS | 29730 | RSS: Main: 230969344 00:01:14 INFO - PROCESS | 29730 | 00:01:17 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60092/tests/kraken/driver.html?testName=audio-dft) 00:01:17 INFO - PROCESS | 29730 | RSS: Main: 216317952 00:01:17 INFO - PROCESS | 29730 | 00:01:21 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60092/tests/kraken/driver.html?testName=audio-fft) 00:01:21 INFO - PROCESS | 29730 | RSS: Main: 298618880 00:01:21 INFO - PROCESS | 29730 | 00:01:23 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60092/tests/kraken/driver.html?testName=audio-oscillator) 00:01:24 INFO - PROCESS | 29730 | RSS: Main: 206905344 00:01:24 INFO - PROCESS | 29730 | 00:01:26 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:01:27 INFO - PROCESS | 29730 | RSS: Main: 212508672 00:01:27 INFO - PROCESS | 29730 | 00:01:30 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60092/tests/kraken/driver.html?testName=imaging-darkroom) 00:01:30 INFO - PROCESS | 29730 | RSS: Main: 249049088 00:01:30 INFO - PROCESS | 29730 | 00:01:33 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60092/tests/kraken/driver.html?testName=imaging-desaturate) 00:01:34 INFO - PROCESS | 29730 | RSS: Main: 247877632 00:01:34 INFO - PROCESS | 29730 | 00:01:37 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60092/tests/kraken/driver.html?testName=json-parse-financial) 00:01:37 INFO - PROCESS | 29730 | RSS: Main: 247390208 00:01:37 INFO - PROCESS | 29730 | 00:01:39 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:01:40 INFO - PROCESS | 29730 | RSS: Main: 209649664 00:01:40 INFO - PROCESS | 29730 | 00:01:41 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60092/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:01:42 INFO - PROCESS | 29730 | RSS: Main: 217501696 00:01:42 INFO - PROCESS | 29730 | 00:01:44 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:01:45 INFO - PROCESS | 29730 | RSS: Main: 225988608 00:01:45 INFO - PROCESS | 29730 | 00:01:47 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:01:48 INFO - PROCESS | 29730 | RSS: Main: 230060032 00:01:48 INFO - PROCESS | 29730 | 00:01:51 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:01:51 INFO - PROCESS | 29730 | RSS: Main: 231931904 00:01:51 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:60092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60092/tests/kraken/driver.html?testName=ai-astar) 00:01:53 INFO - PROCESS | 29730 | RSS: Main: 283570176 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | __start_tp_report 00:01:53 INFO - PROCESS | 29730 | _x_x_mozilla_page_load 00:01:53 INFO - PROCESS | 29730 | _x_x_mozilla_page_load_details 00:01:53 INFO - PROCESS | 29730 | |i|pagename|runs| 00:01:53 INFO - PROCESS | 29730 | |0;ai-astar;114;114;113;117;113;115;112;113;120;111 00:01:53 INFO - PROCESS | 29730 | |1;audio-beat-detection;152;122;121;164;123;123;123;126;158;127 00:01:53 INFO - PROCESS | 29730 | |2;audio-dft;161;162;160;161;161;162;162;161;161;161 00:01:53 INFO - PROCESS | 29730 | |3;audio-fft;76;76;76;113;75;77;76;77;97;74 00:01:53 INFO - PROCESS | 29730 | |4;audio-oscillator;83;82;113;83;83;83;111;82;83;114 00:01:53 INFO - PROCESS | 29730 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;116 00:01:53 INFO - PROCESS | 29730 | |6;imaging-darkroom;145;146;146;145;146;145;147;146;146;147 00:01:53 INFO - PROCESS | 29730 | |7;imaging-desaturate;95;95;94;95;95;95;95;94;95;95 00:01:53 INFO - PROCESS | 29730 | |8;json-parse-financial;53;55;53;52;53;54;55;55;54;54 00:01:53 INFO - PROCESS | 29730 | |9;json-stringify-tinderbox;62;63;62;62;63;62;63;63;63;63 00:01:53 INFO - PROCESS | 29730 | |10;stanford-crypto-aes;80;80;88;83;79;86;80;80;79;79 00:01:53 INFO - PROCESS | 29730 | |11;stanford-crypto-ccm;130;139;140;135;132;137;138;127;182;127 00:01:53 INFO - PROCESS | 29730 | |12;stanford-crypto-pbkdf2;168;164;161;162;165;166;163;167;162;160 00:01:53 INFO - PROCESS | 29730 | |13;stanford-crypto-sha256-iterative;65;68;67;65;64;64;70;64;64;68 00:01:53 INFO - PROCESS | 29730 | __end_tp_report 00:01:53 INFO - PROCESS | 29730 | __start_cc_report 00:01:53 INFO - PROCESS | 29730 | _x_x_mozilla_cycle_collect,1626 00:01:53 INFO - PROCESS | 29730 | __end_cc_report 00:01:53 INFO - PROCESS | 29730 | __startTimestamp1476687713693__endTimestamp 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | ------- Summary: start ------- 00:01:53 INFO - PROCESS | 29730 | Number of tests: 14 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:2.62 (2.3%) stddev-sans-first:2.77 00:01:53 INFO - PROCESS | 29730 | Values: 114.0 114.0 113.0 117.0 113.0 115.0 112.0 113.0 120.0 111.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:126.50 stddev:16.96 (13.4%) stddev-sans-first:16.68 00:01:53 INFO - PROCESS | 29730 | Values: 152.0 122.0 121.0 164.0 123.0 123.0 123.0 126.0 158.0 127.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 00:01:53 INFO - PROCESS | 29730 | Values: 161.0 162.0 160.0 161.0 161.0 162.0 162.0 161.0 161.0 161.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.88 (16.9%) stddev-sans-first:13.49 00:01:53 INFO - PROCESS | 29730 | Values: 76.0 76.0 76.0 113.0 75.0 77.0 76.0 77.0 97.0 74.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:14.49 (17.5%) stddev-sans-first:15.02 00:01:53 INFO - PROCESS | 29730 | Values: 83.0 82.0 113.0 83.0 83.0 83.0 111.0 82.0 83.0 114.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 00:01:53 INFO - PROCESS | 29730 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 00:01:53 INFO - PROCESS | 29730 | Values: 145.0 146.0 146.0 145.0 146.0 145.0 147.0 146.0 146.0 147.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:01:53 INFO - PROCESS | 29730 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.05 00:01:53 INFO - PROCESS | 29730 | Values: 53.0 55.0 53.0 52.0 53.0 54.0 55.0 55.0 54.0 54.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 00:01:53 INFO - PROCESS | 29730 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 63.0 63.0 63.0 63.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.00 stddev:3.20 (4.0%) stddev-sans-first:3.36 00:01:53 INFO - PROCESS | 29730 | Values: 80.0 80.0 88.0 83.0 79.0 86.0 80.0 80.0 79.0 79.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:137.50 stddev:15.94 (11.6%) stddev-sans-first:16.60 00:01:53 INFO - PROCESS | 29730 | Values: 130.0 139.0 140.0 135.0 132.0 137.0 138.0 127.0 182.0 127.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:164.50 stddev:2.66 (1.6%) stddev-sans-first:2.35 00:01:53 INFO - PROCESS | 29730 | Values: 168.0 164.0 161.0 162.0 165.0 166.0 163.0 167.0 162.0 160.0 00:01:53 INFO - PROCESS | 29730 | 00:01:53 INFO - PROCESS | 29730 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:2.18 (3.3%) stddev-sans-first:2.29 00:01:53 INFO - PROCESS | 29730 | Values: 65.0 68.0 67.0 65.0 64.0 64.0 70.0 64.0 64.0 68.0 00:01:53 INFO - PROCESS | 29730 | -------- Summary: end -------- 00:01:53 INFO - PROCESS | 29730 | 00:01:54 INFO - TEST-INFO | 29730: exit 0 00:01:54 INFO - TEST-OK | kraken | took 62002ms 00:01:54 INFO - SUITE-END | took 1178s 00:01:55 INFO - Completed test suite (00:19:39) 00:01:55 INFO - javascript benchmark 00:01:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2912.4903141950153, 2929.414117176565, 2939.91180264592, 2945.3372991077013, 2985.0298652937795, 5050.621203409741, 5107.719075450848, 5115.258287548303, 5163.81926632568, 5203.318549855575, 5117.872053198672, 5151.510606492387, 5153.922691159635, 5184.248283998818, 5192.92210616841, 4651.860444186663, 4695.389599352079, 4727.598154156901, 4743.715377077369, 4774.618030557547, 4756.381670382845, 4767.90464190716, 4777.280144429402, 4793.3768610080815, 4819.156647586676, 4777.665563410563, 4790.0898829222515, 4798.0, 4837.733924634162, 4844.515548445145, 4592.540745925414, 4611.723296602215, 4652.302154676791, 4690.7654617269345, 4775.594074503671, 4682.180618391768, 4686.53134686532, 4713.5993440557595, 4745.501722319142, 4766.070616229837, 5076.74616269185, 5132.204508301182, 5133.589312854962, 5144.125498665236, 5148.819791307286, 5334.786608535654, 5362.249285100089, 5397.595180361489, 5479.260299859548, 5479.4520547945285, 5458.918116228259, 5478.835634930959, 5489.835304940818, 5542.8337149885565, 5550.69471179085, 5132.435432102466, 5138.332016837787, 5142.485751424865, 5142.845714628567, 5217.3999990000875, 5497.615166938356, 5547.11246200606, 5597.412271711493, 5602.915956260659, 5603.915941260884, 5353.598480114007, 5370.543503802142, 5376.784928602812, 5395.622306438511, 5460.726963651801, 5470.206820011076, 5472.20653005312, 5475.479829416199, 5475.5072043516275, 5477.342718873681, 5332.146856502941, 5393.298871146804, 5405.351357837085, 5461.472067621054, 5524.977879092381, 5373.9731301343245, 5424.783008679688, 5433.755481003364, 5443.646162999472, 5516.586256030814, 4327.112941846914, 4330.891727706832, 4367.694261401672, 4376.890577735582, 4377.3433984901885, 3819.197968426606, 3822.8088595570666, 3825.8130967000707, 3852.0947577319307, 3870.2259548090497, 5135.075686376414, 5183.974080129575, 5275.894482110413, 5284.894302113936, 5348.304720386325, 5399.730013499309, 5449.427810079885, 5453.127499600045, 5500.724963751796, 5545.77816887328, 5154.639175257696, 5199.298094757235, 5203.037438073969, 5206.0, 5217.452167522356, 4611.354410382549, 4728.290756386501, 4728.739919304402, 4746.0, 4770.379850619397, 5613.129964855454, 5652.830415087554, 5723.513501352349, 5728.856778580569, 5805.419458054161, 5525.336959564878, 5534.944650553604, 5539.861503462284, 5541.0, 5541.224228608079, 5728.054870946414, 5731.828045158652, 5734.741936612779, 5735.053716136791, 5738.053221218619, 5305.0, 5319.042572337016, 5359.598030147832, 5382.892342153214, 5437.042664640805, 5488.17677348401, 5522.30971128609, 5525.143602741581, 5579.358373786904, 5590.5248053915875, 5367.543758780547, 5381.838544843661, 5386.676799392049, 5388.811391601275, 5393.649412788156, 5244.659097158673, 5283.920741188962, 5348.866278343073, 5357.946420535901, 5372.167314066326, 5403.5136837684795, 5436.184572314184, 5454.863628409322, 5460.2355670207, 5464.2076898848645, 5262.210668399771, 5431.8098866539485, 5433.510984011458, 5436.646617969819, 5438.918416223681, 5162.793488260578, 5193.532582067632, 5202.245674377118, 5243.318368612056, 5263.868403289948], "value": 5080.466366896328, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.1546910572354, 582.016392297018, 600.4085975314317, 600.9218801555799, 609.5306613907294, 42078.0, 43812.3428148578, 43834.12331753363, 48105.3920955928, 48147.51852481474, 43771.34342984858, 44164.77917610415, 44190.33714494285, 44235.3364699529, 44249.77875110628, 7914.129445760962, 8112.647332273663, 8954.059823718513, 9119.452832830018, 9119.544022798867, 10562.26064175508, 10834.512446939907, 10843.51204195809, 11201.551937922473, 11220.270682405617, 10972.615958441456, 11049.226554141213, 11052.392118433523, 11052.557897684082, 11056.502457389397, 10865.619703310385, 10920.0, 10920.617778377718, 10921.617743378984, 10930.617428390047, 10681.0, 10720.08879245265, 10726.946365268124, 10739.033486986209, 10739.24825262232, 42339.0, 42603.36094958578, 42663.58691304719, 42669.0, 42712.0, 3355.328934213143, 3433.4506478963244, 3437.346904088215, 3510.052285882797, 3817.8472861085525, 31011.224719382197, 31093.0, 31216.531752023737, 31285.687143128504, 31424.528632070538, 4325.545817689129, 4456.6880318377725, 4482.238019536687, 4526.932096018562, 4555.863324100283, 342771.0, 344814.0, 345297.0, 345671.0, 345764.0, 56929.71535142298, 57313.42686573164, 57326.7133664329, 57360.70557177749, 57369.0, 60824.0, 61446.385536144066, 61816.69091654513, 61840.0, 61858.0, 15942.920285398499, 16109.19454027294, 16129.677406451805, 16141.0, 16212.189390530662, 11469.426528673534, 11703.590374336858, 11847.289162650268, 12658.367081645882, 12716.809247861289, 16487.67024659524, 16723.331066757437, 16755.748663770053, 17172.570685732706, 17186.398476053277, 6228.719707613078, 6255.780122876086, 6356.68216589178, 6463.159789227464, 6465.2564955030775, 917.6283605139929, 1022.8312328465869, 1105.380986647464, 1109.4840898982013, 1125.2179735084037, 31689.36621267608, 31964.84017579897, 32408.35183296368, 32720.345593088005, 32869.3426131476, 1063.7978784031163, 1102.4653043274006, 1146.8050431426677, 1164.1850704506878, 1181.4506254591483, 16656.250468728937, 17070.146492675565, 17203.397881074103, 17216.0, 17258.741118883227, 514374.0, 523516.6483351634, 524522.0, 525074.0, 525696.0, 58284.41715582875, 58367.0, 58450.0, 58534.12198817021, 58579.12131318034, 1211.5638370186725, 1233.1614502138452, 1312.4750099960092, 1317.6705823544114, 1338.3910320804011, 29991.250218744706, 33553.49669755004, 33687.494687579216, 33862.32275354528, 33989.66010339865, 50841.23738144005, 51812.740936296585, 51886.740566296925, 51920.22119668283, 51931.2210316838, 396622.0, 396853.0, 398277.0, 399788.0, 401027.0, 26823.731762682124, 27536.0, 27914.162575121965, 28127.0, 40947.0, 42721.14557708891, 47693.28460073171, 48053.0, 48158.759206203744, 48459.0, 39439.0, 40469.85904228778, 40674.796626017865, 41029.58970410377, 42637.78681106699, 40016.79991600024, 40638.79680601578, 41000.589994099675, 41467.58532414637, 41529.1694166121, 40526.392104119055, 40928.590714092476, 41033.179336413705, 41213.58786412217, 42326.576734232265, 34310.313793723486, 36877.44683829798, 37103.62896371002, 37198.44202336913, 37284.62715372811, 27888.0, 28161.0, 28409.28976775597, 28469.288267793472, 28472.0], "value": 20384.889538826308, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.43445311446936, 394.1820722001847, 401.9658329042032, 403.87479881236817, 421.5236782435847, 13713.45146194151, 15602.531924042283, 18925.905370473163, 19009.71485427716, 19321.516962075955, 18607.534811629717, 18768.0, 18907.149178286974, 19352.51618709533, 19419.805801941977, 5438.700871452069, 5522.254495643087, 5767.36558978512, 5771.740271687784, 5777.277840269966, 5549.805756798512, 5578.30271216098, 5617.887642247153, 5623.775048998035, 5633.15502674598, 5607.0, 5610.354809196933, 5614.438556144373, 5645.8588535286535, 6168.0, 6387.297397286295, 6480.935190648081, 6497.0, 6497.057926600663, 6497.675116244169, 5643.238162848004, 5792.68140252286, 5821.039528477796, 5837.854053648651, 5845.532357411439, 13596.116252443659, 13635.181889086587, 13702.0, 18970.81029189718, 22515.54968900613, 2309.5034567568055, 2373.5015646714037, 2626.868656567164, 2874.9334275716915, 2937.529995200779, 8984.281257499384, 9019.954900225457, 9430.339876208669, 9753.658621948198, 9997.900020999843, 1779.74193741908, 1861.1996841358211, 1876.3339014649875, 1902.7050807124917, 1919.9520011999812, 73456.0, 78637.60681196615, 79876.0, 80988.19011809866, 82501.0, 10794.298370605886, 10880.12958963281, 10904.182186336056, 10933.453327333602, 11320.0, 15514.767278490832, 15527.223638818014, 15534.844651553565, 15544.844551554339, 15549.222538873011, 7563.508371955805, 7835.451518393657, 7946.6424010919645, 7985.281324680806, 8012.439129260896, 7297.270272972766, 7322.0, 7407.333339999318, 7517.17311095779, 7523.442029709816, 4515.435570553681, 4679.9298010529865, 4726.669133160645, 4843.297721830315, 4871.902561948741, 1904.6762050451457, 1908.9713654295197, 1910.8184722451344, 1981.2669312354521, 1986.8410527157794, 848.9395728399155, 948.3645957208687, 988.3476905242649, 1001.409168590535, 1019.9898001019894, 19098.71351929722, 19449.12478938451, 19502.414927552196, 19570.51073723168, 19752.209911603375, 950.5294879034922, 972.8394814855469, 1017.1913328903539, 1035.9689209323733, 1097.5664612478186, 9118.544072796467, 10675.733106672395, 10882.891171088188, 10885.945570272099, 10912.345259284468, 343114.0, 344306.0, 428392.0, 463849.0, 485261.0, 73581.63209184026, 85865.57067214623, 90422.0, 92779.08313752992, 97205.0, 463.49710564037724, 475.0451592299503, 477.0482886641173, 480.68274938540395, 481.0907385042273, 10491.160707143563, 10768.730781730206, 11006.559737610405, 11117.0, 11161.33032018049, 40352.3947140799, 40938.0, 41528.37707434451, 41948.58051419569, 41970.37044444275, 57154.42845571491, 57466.13800793075, 57859.13211301918, 58514.4148558509, 58648.120278196715, 7989.2809647132035, 8225.917740822755, 8230.958845205736, 8379.078301386964, 8530.573471326534, 12242.405588017748, 13269.270190139636, 13333.466661333438, 13721.0, 13926.58220253394, 11227.326360418401, 11437.656870293904, 11797.646070617895, 11979.940100299442, 11998.340091295062, 11298.209125361474, 11381.886181138083, 11433.714157145805, 11537.653870383901, 12050.09624278165, 10857.565697372016, 11236.831447528457, 11456.140789440658, 11763.294202347886, 11808.350540720343, 8129.390295727726, 8279.875801862856, 8287.958560207402, 8481.194286542768, 8503.91496085056, 9768.462734549385, 10924.2899211551, 11243.943780281046, 11340.6030788922, 11869.5845645402], "value": 8709.27593973203, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.8006539051844, 1485.502356710502, 1489.4637930345075, 1679.7480377943307, 1833.3399976008634, 7973.282404583586, 8757.080506546816, 9073.0, 9081.182693557586, 9368.250539956804, 9136.451812891215, 9195.862062069074, 9206.907930920688, 9208.309376796751, 9209.447433153999, 2329.8951547180377, 2356.7643235676464, 2359.764023597635, 2362.9409264768433, 2367.8105751539833, 2263.875486848223, 2283.1894677389537, 2348.1429278313462, 2353.8234632402555, 2356.0340260493203, 2325.4186453386656, 2332.7667233276707, 2344.765523447659, 2357.5049239659606, 2358.882055897207, 2223.377454312779, 2251.3020963501285, 2255.661650752384, 2265.014718597407, 2270.7842754938256, 2275.943101422461, 2312.28319221042, 2314.756950520188, 2317.2005658047947, 2319.675245465636, 9043.819123617492, 9117.726468205965, 9184.8622270666, 9195.954020229923, 9200.539973001323, 5161.251618515332, 5383.542398896098, 5389.083855744533, 5393.4336894626285, 5398.595105367113, 3606.945895811565, 3640.2719456108885, 3674.6325367463305, 3695.4826324314618, 3696.2977034363385, 1131.0894729742554, 1158.139395692638, 1167.4629670351649, 1187.8337032815414, 1198.6284251881943, 12595.874041259562, 12791.808122878072, 12824.102312838106, 12841.807372889414, 12854.742905141939, 4313.223619748413, 4450.599446049806, 4601.7699115044115, 4614.238650622677, 4636.374089497942, 10030.097291243823, 10047.196224302039, 10050.296479246383, 10059.0, 10060.0945914868, 5212.139996900545, 5227.3465816772905, 5246.081935661244, 5256.526912577886, 5256.947430525723, 4355.673324500675, 4471.61991230749, 4580.908381832344, 4678.415198100238, 4909.87725306863, 3566.4472006838982, 3584.623614520438, 3639.763415377992, 3662.8351724172476, 3797.9810100949317, 1062.6705721226444, 1065.5950738719391, 1068.4390694885246, 1070.5182667799522, 1091.1816137896578, 910.3854897943861, 922.4050487435567, 943.1464524605243, 950.8716323296405, 972.6936015155345, 5698.515626171739, 5850.3564607893095, 5918.556108291896, 6146.4468197861515, 6177.505799536027, 409.040799325581, 415.9958400415957, 421.50473193997544, 423.58911855500116, 427.5382586806304, 3999.460072890181, 4052.8986775330854, 4061.3095773718537, 4069.5320038195987, 4099.590040995936, 10745.409002504937, 10839.295445795999, 11119.722006949729, 11174.944125279484, 11524.88475115255, 11383.203175777782, 11444.370559619301, 11470.88529114715, 11472.942635286938, 11487.827682584768, 8321.625526851307, 8548.871766923377, 8641.265492433213, 8671.6531338747, 8677.435966662148, 5871.207387002871, 5889.5582831286965, 6075.544334175043, 6145.938540614716, 6263.780767673292, 9855.704328870146, 10342.276040677081, 10375.63685271042, 10425.687229383131, 10616.84074738864, 10334.844977325496, 10485.161187105166, 10560.313579617301, 10652.84020739674, 10653.094486968694, 7158.425146467769, 7317.780466586011, 7713.035870516185, 7766.8446631065935, 7944.165862584346, 8660.78348041304, 8789.736307910773, 8803.0, 8812.91187088121, 8827.426217295855, 7807.0, 7914.762557123296, 8020.598970051591, 8127.674893004214, 8223.136570660234, 7703.268189521987, 7749.7675069748, 7864.724734634489, 7879.212078792075, 7890.802729931797, 6976.197737260077, 7086.681099350439, 7092.5389849659605, 7094.0, 7097.183823860116, 4722.338872557913, 4770.570648641639, 4852.078105160008, 5028.033460258465, 5149.510796474329, 5222.451642577475, 5227.137522308929, 5241.921371179359, 5293.973530132324, 5332.653377530448], "value": 4555.494549170243, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.995350069749, 319.55900856817595, 322.87730662348304, 322.9564008858803, 326.81861566830406, 4979.626528010395, 5156.648178683858, 5170.603936937025, 5218.660787048844, 5246.501582349675, 5056.241563765437, 5131.230315452684, 5136.152534831748, 5136.486351364862, 5152.768125434355, 4072.9592704072875, 4074.5517993020744, 4087.407325937752, 4092.1815636872598, 4096.344584866422, 3957.4657421248194, 4069.837206511736, 4111.136661301115, 4122.2992091344395, 4155.542890282067, 4051.4530538377385, 4052.878413647595, 4054.574269701683, 4068.6338229559333, 4069.0844559973916, 4046.979765101156, 4049.3521036634143, 4054.493188351456, 4056.1887622475474, 4062.837486500536, 3607.512985746917, 3608.3144202601684, 3608.3144202601684, 3613.1328481164596, 3651.233241019389, 4867.634927380425, 5019.949800502021, 5064.898702025939, 5070.518300761421, 5074.021131758617, 4568.977155114237, 4574.336721175444, 4584.541545845422, 4587.977060114678, 4623.352730617717, 5394.973025134888, 5407.621466497347, 5409.486098820606, 5411.675299482044, 5460.0, 3659.579148397915, 3835.520559930009, 3848.84534639607, 3866.8066596670055, 3897.512810898638, 5513.558915286808, 5525.0, 5565.0, 5566.777328906798, 5571.331440227158, 3930.4104384342004, 3948.545917219499, 3955.5253369595835, 3965.4250133731025, 3988.9828093835886, 3935.5277366716177, 3956.624120708528, 3980.144268982183, 4033.1328764315813, 4037.1320166164414, 4528.184926713223, 4536.298887917031, 4541.909161816745, 4547.067851090518, 4553.702194874445, 5401.918971215435, 5420.864478388072, 5430.619856610078, 5437.8368648940595, 5443.401225865152, 1302.2251760202664, 1315.2043013976597, 1334.172812856016, 1356.0168877563688, 1382.3710211853584, 915.1946287267162, 929.9256059515222, 944.9841420473019, 953.6233187890745, 958.5734348215117, 5207.401148867929, 5221.686698798084, 5250.0, 5251.921221181686, 5255.343082114736, 5486.698231597221, 5494.2582751328055, 5500.944990550123, 5509.338879334426, 5531.2809334787025, 4966.634175601738, 5128.512791284822, 5209.463208353544, 5233.345831771028, 5234.581233501311, 2513.7611926866916, 2546.681664791901, 2547.2805856047094, 2568.845869247814, 2577.4071963448514, 4952.430470495867, 4967.875803104879, 4978.701277923336, 4997.375852847839, 5026.949730502648, 4642.025174713348, 4857.231378114511, 4903.37150508621, 4914.70511769295, 4936.925946110811, 4953.578945789504, 4958.529029679239, 4961.702297862068, 4972.229304457815, 4977.303177555145, 4774.379330686988, 4831.130396528518, 4837.346958160744, 4840.273958906192, 4884.096442158212, 4567.38340324052, 4713.373886009322, 4769.902922327815, 4786.497417771223, 4788.61691064721, 5024.5679981205185, 5033.062271025608, 5033.546980771748, 5044.225675878326, 5050.040492306597, 3550.5206797083097, 3578.982105089458, 3581.767185132958, 3600.801955892451, 3601.85592576294, 4660.159237101394, 4781.976090119527, 4876.463589005278, 4887.780049897692, 4935.876603084808, 4656.720596764205, 4656.743879086683, 4662.836800712094, 4684.789184486638, 4749.4063242094735, 4662.2307319293295, 4696.835610753607, 4700.318453824245, 4714.787834547385, 4737.786799593958, 4391.429114215131, 4627.051454451762, 4659.088069956278, 4665.183592871302, 4679.251319788817, 4678.60231880294, 4686.687727436323, 4701.89505466222, 4713.410823647044, 4715.646326525456, 4616.737798478788, 4629.236176030917, 4651.186032450454, 4670.789814458425, 4721.527847215389], "value": 3915.6560697233353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.4007194064897, 827.2513375395266, 827.9917200827994, 828.246295870757, 828.8710119299647, 15799.84200157998, 16825.83174168258, 16834.410795622156, 16846.0, 16864.40974565889, 14793.482228122019, 14885.255737213123, 14887.330070146842, 14894.329755161016, 14911.850881491182, 655.9868802623945, 659.2188256915571, 781.1173374087274, 794.5232860283842, 813.6785969542027, 809.0655293136407, 814.0760237130839, 822.6503735912244, 822.880682301066, 823.189158678701, 855.482433127958, 862.021605477781, 863.5725315968605, 863.8445079885618, 864.7535452396069, 679.3715812873122, 692.7609974558819, 856.7344123321759, 859.2953777902092, 859.497194141428, 610.6671863834221, 615.1510914937357, 624.687656171914, 631.4411745605126, 632.1592282264577, 15008.849911500854, 15013.924930375388, 15028.0, 15031.549053528412, 15032.774508382383, 13458.798118028237, 13782.724345513134, 13956.302184890816, 14050.92974535131, 14097.577072687836, 12967.157134786208, 13078.881415368183, 13144.6713832154, 13175.868241317656, 13407.455853499026, 4312.568743125694, 4329.328954012133, 4367.148406060819, 4393.5606439356125, 4410.206162890679, 78396.60801695955, 78697.21302786955, 79314.0, 80358.59820700917, 82921.17078829255, 11151.944240278908, 11154.609588664358, 11187.384693841754, 11270.21108522412, 11278.943605282086, 21919.0, 21923.78076219249, 21962.560748784934, 22097.55804883893, 22111.336659899905, 8222.62998165084, 8310.916890831015, 8373.539455330016, 8398.958005210057, 8419.747407577783, 4406.140802543473, 4442.6890117691455, 4562.543745625478, 4694.29984964348, 4699.976500117477, 3466.0, 3569.23261498779, 3578.3916734155255, 3578.4453409721536, 3581.122624956902, 606.7178761875749, 608.9147519347295, 618.7679620142446, 619.1672200889795, 620.1163342237294, 569.0354848531699, 578.9218455508536, 613.2640831002815, 684.7945616315086, 723.1394640377933, 9668.574153552716, 9823.852642210373, 10059.69820905374, 10126.139278161292, 10466.790664186674, 631.2046821005474, 669.7421492725335, 683.4634811672813, 702.1223470661673, 725.0067407651446, 4623.260278355514, 4811.106235289458, 4856.95143048572, 4880.633952453581, 4908.239222920453, 71224.2877571228, 97944.0, 122867.0, 125785.37107314589, 131214.0, 98084.50957745165, 98226.0, 99125.50437247768, 107330.0, 110308.0, 58732.0, 66669.66665166643, 91661.54169229245, 94755.99999999862, 95716.0, 8878.689245876363, 9070.818583628423, 9089.545522723705, 9097.49963752, 9162.221211197122, 38103.756708407294, 42507.3623895648, 51169.0, 52924.735376322875, 54726.179107314216, 69851.65074174597, 69971.0, 72023.0, 72038.63980680062, 73070.63464682642, 13190.934045329712, 13210.405531751287, 13259.933700331823, 13263.867361326264, 13802.930985345009, 14714.55856324312, 14879.941850334415, 14973.475928342456, 15026.624334391729, 15417.306221220297, 13905.791413129013, 14120.717585648024, 14574.34415451286, 14583.343749531508, 14697.338619761922, 12684.619461416172, 12941.28822914711, 13132.73734525285, 13483.19100853952, 13780.586582402544, 11862.347570883685, 12504.0, 12611.87388126107, 13470.73058538804, 14990.100593964396, 10763.838542421714, 11325.603663406859, 11593.0, 12085.274883506667, 12229.633111006684, 11394.37330946806, 11540.480678369326, 11701.122415819018, 12038.277703337828, 12084.335361554848], "value": 7553.151326427064, "unit": "score"}], "name": "dromaeo_css", "value": 7038.045427735889, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 117.0, 113.0, 115.0, 112.0, 113.0, 120.0, 111.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 121.0, 164.0, 123.0, 123.0, 123.0, 126.0, 158.0, 127.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 113.0, 75.0, 77.0, 76.0, 77.0, 97.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 113.0, 83.0, 83.0, 83.0, 111.0, 82.0, 83.0, 114.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 52.0, 53.0, 54.0, 55.0, 55.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 88.0, 83.0, 79.0, 86.0, 80.0, 80.0, 79.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 139.0, 140.0, 135.0, 132.0, 137.0, 138.0, 127.0, 182.0, 127.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 161.0, 162.0, 165.0, 166.0, 163.0, 167.0, 162.0, 160.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 65.0, 64.0, 64.0, 70.0, 64.0, 64.0, 68.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1506.3000000000002, "alertThreshold": 2.0}]} 00:01:55 INFO - Return code: 0 00:01:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:01:55 INFO - # TBPL SUCCESS # 00:01:55 INFO - Running post-action listener: _resource_record_post_action 00:01:55 INFO - [mozharness: 2016-10-17 07:01:55.469325Z] Finished run-tests step (success) 00:01:55 INFO - Running post-run listener: _resource_record_post_run 00:01:55 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391561216; Read time: 12; Write time: 252456 00:01:55 INFO - TinderboxPrint: CPU usage
13.1% 00:01:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 00:01:55 INFO - TinderboxPrint: I/O write bytes / time
391,561,216 / 252,456 00:01:55 INFO - TinderboxPrint: CPU idle
8,286.8 (86.8%) 00:01:55 INFO - TinderboxPrint: CPU user
1,205.0 (12.6%) 00:01:55 INFO - TinderboxPrint: Swap in / out
0 / 0 00:01:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103919616; Read time: 0; Write time: 67432 00:01:55 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287641600; Read time: 0; Write time: 185024 00:01:56 INFO - Running post-run listener: _upload_blobber_files 00:01:56 INFO - Blob upload gear active. 00:01:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:01:56 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 00:01:56 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'] 00:01:56 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 00:01:56 INFO - (blobuploader) - INFO - Open directory for files ... 00:01:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:01:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:01:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:01:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:01:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:01:57 INFO - (blobuploader) - INFO - Done attempting. 00:01:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:01:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:01:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:02:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:02:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:02:01 INFO - (blobuploader) - INFO - Done attempting. 00:02:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:02:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:02:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:02:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:02:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:02:02 INFO - (blobuploader) - INFO - Done attempting. 00:02:02 INFO - (blobuploader) - INFO - Iteration through files over. 00:02:02 INFO - Return code: 0 00:02:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:02:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:02:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74470aa3584c3c2268fa0cf55c07b61e6c02a90b50c87be746dc422405cfec11f58b8b8c3542d79f3953f4fa06262b1a5a27926c5bf18690c14d0b2ee8ee06a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3aa2e1ea3b24a6767688659d11eedf84d192428fe39905bef7f6fa51c4125d8797fe7e60e80ffac7efbc73ff7490d2dc87a9a8d8a934622d52fe6f9783ea7b3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e61b7da5e2be176c43070f5d80e8f577300a38666351fd856404cb32328f8ea0e48c4722ec4d895213ebb6509168a49cc7e8f5ef470ba105dcae8c59a7d0d5f"} 00:02:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:02:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:02:02 INFO - Contents: 00:02:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74470aa3584c3c2268fa0cf55c07b61e6c02a90b50c87be746dc422405cfec11f58b8b8c3542d79f3953f4fa06262b1a5a27926c5bf18690c14d0b2ee8ee06a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3aa2e1ea3b24a6767688659d11eedf84d192428fe39905bef7f6fa51c4125d8797fe7e60e80ffac7efbc73ff7490d2dc87a9a8d8a934622d52fe6f9783ea7b3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e61b7da5e2be176c43070f5d80e8f577300a38666351fd856404cb32328f8ea0e48c4722ec4d895213ebb6509168a49cc7e8f5ef470ba105dcae8c59a7d0d5f"} 00:02:02 INFO - Running post-run listener: copy_logs_to_upload_dir 00:02:02 INFO - Copying logs to upload dir... 00:02:02 INFO - mkdir: /builds/slave/test/build/upload/logs 00:02:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.127292 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-17 00:02:02.529088) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 00:02:02.533506) ========= 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=00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499 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/74470aa3584c3c2268fa0cf55c07b61e6c02a90b50c87be746dc422405cfec11f58b8b8c3542d79f3953f4fa06262b1a5a27926c5bf18690c14d0b2ee8ee06a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3aa2e1ea3b24a6767688659d11eedf84d192428fe39905bef7f6fa51c4125d8797fe7e60e80ffac7efbc73ff7490d2dc87a9a8d8a934622d52fe6f9783ea7b3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e61b7da5e2be176c43070f5d80e8f577300a38666351fd856404cb32328f8ea0e48c4722ec4d895213ebb6509168a49cc7e8f5ef470ba105dcae8c59a7d0d5f"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011460 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674090/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/74470aa3584c3c2268fa0cf55c07b61e6c02a90b50c87be746dc422405cfec11f58b8b8c3542d79f3953f4fa06262b1a5a27926c5bf18690c14d0b2ee8ee06a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3aa2e1ea3b24a6767688659d11eedf84d192428fe39905bef7f6fa51c4125d8797fe7e60e80ffac7efbc73ff7490d2dc87a9a8d8a934622d52fe6f9783ea7b3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e61b7da5e2be176c43070f5d80e8f577300a38666351fd856404cb32328f8ea0e48c4722ec4d895213ebb6509168a49cc7e8f5ef470ba105dcae8c59a7d0d5f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 00:02:02.564940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 00:02:02.565330) ========= 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=00204705a9daa57ed339a427000001b9-1476686482.633875-1520088499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 00:02:02.647835) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 00:02:02.648222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 00:02:02.648610) ========= ========= Total master_lag: 0.20 =========