builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1475902774.66 results: success (0) buildid: 20161007215206 builduid: 48dbe3f0465f4b219928d470155e14f7 revision: 5c67c91fc9cac4f3df0f4dd85b6d6c8cb3140fa3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:34.664003) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:34.664861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:34.665458) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:34.681785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:34.682436) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 21:59:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.4M=0s 2016-10-07 21:59:34 (38.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150812 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:34.849659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:34.850207) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014427 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:34.902889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:34.903675) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5c67c91fc9cac4f3df0f4dd85b6d6c8cb3140fa3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 5c67c91fc9cac4f3df0f4dd85b6d6c8cb3140fa3 --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=74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 21:59:35,121 truncating revision to first 12 chars 2016-10-07 21:59:35,121 Setting DEBUG logging. 2016-10-07 21:59:35,121 attempt 1/10 2016-10-07 21:59:35,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5c67c91fc9ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 21:59:35,443 unpacking tar archive at: autoland-5c67c91fc9ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701209 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:35.620722) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:35.621101) ========= script_repo_revision: 5c67c91fc9cac4f3df0f4dd85b6d6c8cb3140fa3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:35.621581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:35.621899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:59:35.631869) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-07 21:59:35.632875) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:35 INFO - MultiFileLogger online at 20161007 21:59:35 in /builds/slave/test 21:59:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:59:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:35 INFO - {'append_to_log': False, 21:59:35 INFO - 'base_work_dir': '/builds/slave/test', 21:59:35 INFO - 'blob_upload_branch': 'Autoland', 21:59:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:35 INFO - 'branch': 'Autoland', 21:59:35 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:35 INFO - 'config_files': ('talos/linux_config.py',), 21:59:35 INFO - 'default_actions': ('clobber', 21:59:35 INFO - 'read-buildbot-config', 21:59:35 INFO - 'download-and-extract', 21:59:35 INFO - 'populate-webroot', 21:59:35 INFO - 'create-virtualenv', 21:59:35 INFO - 'install', 21:59:35 INFO - 'run-tests'), 21:59:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:35 INFO - 'download_minidump_stackwalk': True, 21:59:35 INFO - 'download_symbols': 'ondemand', 21:59:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:35 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:35 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:35 INFO - 'installer_path': 'installer.exe', 21:59:35 INFO - 'log_level': 'info', 21:59:35 INFO - 'log_name': 'talos', 21:59:35 INFO - 'log_to_console': True, 21:59:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:35 INFO - 'opt_config_files': (), 21:59:35 INFO - 'pip_index': False, 21:59:35 INFO - 'sps_profile': False, 21:59:35 INFO - 'sps_profile_interval': 0, 21:59:35 INFO - 'suite': 'dromaeojs', 21:59:35 INFO - 'system_bits': '32', 21:59:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:35 INFO - 'title': 'talos-linux64-ix-042', 21:59:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:35 INFO - 'use_talos_json': True, 21:59:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:35 INFO - 'work_dir': 'build'} 21:59:35 INFO - [mozharness: 2016-10-08 04:59:35.945665Z] Running clobber step. 21:59:35 INFO - Running pre-action listener: _resource_record_pre_action 21:59:35 INFO - Running main action method: clobber 21:59:35 INFO - rmtree: /builds/slave/test/build 21:59:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:36 INFO - Running post-action listener: _resource_record_post_action 21:59:36 INFO - [mozharness: 2016-10-08 04:59:36.934383Z] Finished clobber step (success) 21:59:36 INFO - [mozharness: 2016-10-08 04:59:36.934486Z] Running read-buildbot-config step. 21:59:36 INFO - Running pre-action listener: _resource_record_pre_action 21:59:36 INFO - Running main action method: read_buildbot_config 21:59:36 INFO - Using buildbot properties: 21:59:36 INFO - { 21:59:36 INFO - "project": "", 21:59:36 INFO - "product": "firefox", 21:59:36 INFO - "script_repo_revision": "production", 21:59:36 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:59:36 INFO - "repository": "", 21:59:36 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 21:59:36 INFO - "buildid": "20161007215206", 21:59:36 INFO - "stage_platform": "linux64-pgo", 21:59:36 INFO - "basedir": "/builds/slave/test", 21:59:36 INFO - "buildnumber": 335, 21:59:36 INFO - "platform": "ubuntu64_hw", 21:59:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:59:36 INFO - "slavebuilddir": "test", 21:59:36 INFO - "branch": "autoland", 21:59:36 INFO - "revision": "5c67c91fc9cac4f3df0f4dd85b6d6c8cb3140fa3", 21:59:36 INFO - "slavename": "talos-linux64-ix-042", 21:59:36 INFO - "builduid": "48dbe3f0465f4b219928d470155e14f7", 21:59:36 INFO - "repo_path": "integration/autoland" 21:59:36 INFO - } 21:59:36 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:59:36 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 21:59:36 INFO - Running post-action listener: _resource_record_post_action 21:59:36 INFO - [mozharness: 2016-10-08 04:59:36.936851Z] Finished read-buildbot-config step (success) 21:59:36 INFO - [mozharness: 2016-10-08 04:59:36.936940Z] Running download-and-extract step. 21:59:36 INFO - Running pre-action listener: _resource_record_pre_action 21:59:36 INFO - Running main action method: download_and_extract 21:59:36 INFO - mkdir: /builds/slave/test/build/tests 21:59:36 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')]} 21:59:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:59:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/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 21:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/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 21:59:36 INFO - Downloaded 1361 bytes. 21:59:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:59:36 INFO - Using the following test package requirements: 21:59:36 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:36 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:36 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:36 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:36 INFO - u'jsshell-linux-x86_64.zip'], 21:59:36 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:36 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:36 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:36 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:36 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:36 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:59:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:59:36 INFO - Http code: 200 21:59:36 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 21:59:36 INFO - x-amz-cf-id: 150c0FT5kKLiV5oPysJa-dnZkyyGisFwomQh4t5E_KqNdRMJJfTM3g== 21:59:36 INFO - x-amz-replication-status: COMPLETED 21:59:36 INFO - x-amz-version-id: lXlyx4dZtN6nfUd32XAIF9i1OapU1qn. 21:59:37 INFO - Expected file size: 22024086 21:59:37 INFO - Obtained file size: 22024086 21:59:41 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 21:59:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:59:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:59:41 INFO - Http code: 200 21:59:41 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 21:59:41 INFO - x-amz-cf-id: XijxN01kQF74Pei5MtTe_a4h9NVoMYVetq3Oxq7RMIYu05Wv-OI8IA== 21:59:41 INFO - x-amz-replication-status: COMPLETED 21:59:41 INFO - x-amz-version-id: lXlyx4dZtN6nfUd32XAIF9i1OapU1qn. 21:59:42 INFO - Expected file size: 22024086 21:59:42 INFO - Obtained file size: 22024086 21:59:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:59:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:59:46 INFO - Http code: 200 21:59:46 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 21:59:46 INFO - x-amz-cf-id: VCtm0WfEbTA3L3srNHjLvCeZnEykPV4cByiiYcqlQWzRXMgYgv447w== 21:59:46 INFO - x-amz-replication-status: COMPLETED 21:59:46 INFO - x-amz-version-id: 5yNNMklqWP5XFmGnt028uzcTBN5Xfq0w 21:59:46 INFO - Expected file size: 14409006 21:59:46 INFO - Obtained file size: 14409006 21:59: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')]} 21:59:47 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:59:47 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/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 21:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/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 21:59:47 INFO - Downloaded 59699101 bytes. 21:59:47 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:59:47 INFO - mkdir: /builds/slave/test/properties 21:59:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:47 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:47 INFO - Contents: 21:59:47 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:59:47 INFO - Running post-action listener: _resource_record_post_action 21:59:47 INFO - Running post-action listener: set_extra_try_arguments 21:59:47 INFO - [mozharness: 2016-10-08 04:59:47.995958Z] Finished download-and-extract step (success) 21:59:47 INFO - [mozharness: 2016-10-08 04:59:47.996188Z] Running populate-webroot step. 21:59:47 INFO - Running pre-action listener: _resource_record_pre_action 21:59:47 INFO - Running main action method: populate_webroot 21:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:48 INFO - '--tppagecycles', 21:59:48 INFO - '7'], 21:59:48 INFO - 'tests': ['tsvgm']}}, 21:59:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['damp', 'tps']}, 21:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'tests': ['damp', 'tps']}, 21:59:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['dromaeo_dom']}, 21:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['basic_compositor_video']}, 21:59:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:59:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['tsvgx', 21:59:48 INFO - 'tsvgr_opacity', 21:59:48 INFO - 'tart', 21:59:48 INFO - 'tscrollx', 21:59:48 INFO - 'cart']}, 21:59:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:48 INFO - 'tsvgr_opacity', 21:59:48 INFO - 'tart', 21:59:48 INFO - 'tscrollx', 21:59:48 INFO - 'cart']}, 21:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['tp5o']}, 21:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'tests': ['tp5o']}, 21:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--disable-e10s', 21:59:48 INFO - '--xperf_path', 21:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:48 INFO - 'tests': ['tp5n']}, 21:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--xperf_path', 21:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:48 INFO - 'tests': ['tp5n']}}, 21:59:48 INFO - 'talos.zip': {'path': '', 21:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:48 INFO - Running post-action listener: _resource_record_post_action 21:59:48 INFO - [mozharness: 2016-10-08 04:59:48.013149Z] Finished populate-webroot step (success) 21:59:48 INFO - [mozharness: 2016-10-08 04:59:48.013238Z] Running create-virtualenv step. 21:59:48 INFO - Running pre-action listener: _resource_record_pre_action 21:59:48 INFO - Running main action method: create_virtualenv 21:59:48 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59:48 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 21:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:48 INFO - Using real prefix '/usr' 21:59:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:48 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:50 INFO - Installing pip.................done. 21:59:50 INFO - Return code: 0 21:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:59:50 INFO - Reading from file tmpfile_stdout 21:59:50 INFO - Output received: 21:59:50 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) 21:59:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:50 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 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 21:59:50 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 21:59:50 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 21:59:50 INFO - Using env: {'DISPLAY': ':0', 21:59:50 INFO - 'HOME': '/home/cltbld', 21:59:50 INFO - 'LANG': 'en_US.UTF-8', 21:59:50 INFO - 'LANGUAGE': 'en_US:en', 21:59:50 INFO - 'LOGNAME': 'cltbld', 21:59:50 INFO - 'MAIL': '/var/mail/cltbld', 21:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:50 INFO - 'MOZ_NO_REMOTE': '1', 21:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:50 INFO - 'NO_EM_RESTART': '1', 21:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:50 INFO - 'PWD': '/builds/slave/test', 21:59:50 INFO - 'SHELL': '/bin/bash', 21:59:50 INFO - 'SHLVL': '1', 21:59:50 INFO - 'TERM': 'linux', 21:59:50 INFO - 'TMOUT': '86400', 21:59:50 INFO - 'USER': 'cltbld', 21:59:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 21:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:50 INFO - '_': '/tools/buildbot/bin/python'} 21:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:51 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 21:59:51 INFO - Cleaning up... 21:59:51 INFO - Return code: 0 21:59:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 21:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:59:51 INFO - Using env: {'DISPLAY': ':0', 21:59:51 INFO - 'HOME': '/home/cltbld', 21:59:51 INFO - 'LANG': 'en_US.UTF-8', 21:59:51 INFO - 'LANGUAGE': 'en_US:en', 21:59:51 INFO - 'LOGNAME': 'cltbld', 21:59:51 INFO - 'MAIL': '/var/mail/cltbld', 21:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:51 INFO - 'MOZ_NO_REMOTE': '1', 21:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:51 INFO - 'NO_EM_RESTART': '1', 21:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:51 INFO - 'PWD': '/builds/slave/test', 21:59:51 INFO - 'SHELL': '/bin/bash', 21:59:51 INFO - 'SHLVL': '1', 21:59:51 INFO - 'TERM': 'linux', 21:59:51 INFO - 'TMOUT': '86400', 21:59:51 INFO - 'USER': 'cltbld', 21:59:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 21:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:51 INFO - '_': '/tools/buildbot/bin/python'} 21:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:51 INFO - Downloading/unpacking psutil>=3.1.1 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:53 INFO - Installing collected packages: psutil 21:59:53 INFO - Running setup.py install for psutil 21:59:53 INFO - building 'psutil._psutil_linux' extension 21:59:53 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 21:59:53 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 21:59:53 INFO - building 'psutil._psutil_posix' extension 21:59:53 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 21:59:53 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 21:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:53 INFO - Successfully installed psutil 21:59:53 INFO - Cleaning up... 21:59:53 INFO - Return code: 0 21:59:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 21:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:59:53 INFO - Using env: {'DISPLAY': ':0', 21:59:53 INFO - 'HOME': '/home/cltbld', 21:59:53 INFO - 'LANG': 'en_US.UTF-8', 21:59:53 INFO - 'LANGUAGE': 'en_US:en', 21:59:53 INFO - 'LOGNAME': 'cltbld', 21:59:53 INFO - 'MAIL': '/var/mail/cltbld', 21:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:53 INFO - 'MOZ_NO_REMOTE': '1', 21:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:53 INFO - 'NO_EM_RESTART': '1', 21:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:53 INFO - 'PWD': '/builds/slave/test', 21:59:53 INFO - 'SHELL': '/bin/bash', 21:59:53 INFO - 'SHLVL': '1', 21:59:53 INFO - 'TERM': 'linux', 21:59:53 INFO - 'TMOUT': '86400', 21:59:53 INFO - 'USER': 'cltbld', 21:59:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 21:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:53 INFO - '_': '/tools/buildbot/bin/python'} 21:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:59:54 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 21:59:54 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 21:59:54 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 21:59:54 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 21:59:54 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 21:59:54 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 21:59:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:59:55 INFO - Installing collected packages: mozsystemmonitor 21:59:55 INFO - Running setup.py install for mozsystemmonitor 21:59:56 INFO - Successfully installed mozsystemmonitor 21:59:56 INFO - Cleaning up... 21:59:56 INFO - Return code: 0 21:59:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 21:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:59:56 INFO - Using env: {'DISPLAY': ':0', 21:59:56 INFO - 'HOME': '/home/cltbld', 21:59:56 INFO - 'LANG': 'en_US.UTF-8', 21:59:56 INFO - 'LANGUAGE': 'en_US:en', 21:59:56 INFO - 'LOGNAME': 'cltbld', 21:59:56 INFO - 'MAIL': '/var/mail/cltbld', 21:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:56 INFO - 'MOZ_NO_REMOTE': '1', 21:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:56 INFO - 'NO_EM_RESTART': '1', 21:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:56 INFO - 'PWD': '/builds/slave/test', 21:59:56 INFO - 'SHELL': '/bin/bash', 21:59:56 INFO - 'SHLVL': '1', 21:59:56 INFO - 'TERM': 'linux', 21:59:56 INFO - 'TMOUT': '86400', 21:59:56 INFO - 'USER': 'cltbld', 21:59:56 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 21:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:56 INFO - '_': '/tools/buildbot/bin/python'} 21:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:56 INFO - Downloading/unpacking jsonschema==2.5.1 21:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:59:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:58 INFO - Downloading functools32-3.2.3-2.tar.gz 21:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:59:58 INFO - warning: no files found matching '*.txt' 21:59:58 INFO - no previously-included directories found matching 'build' 21:59:58 INFO - no previously-included directories found matching 'dist' 21:59:58 INFO - no previously-included directories found matching '.git*' 21:59:58 INFO - Installing collected packages: jsonschema, functools32 21:59:58 INFO - Running setup.py install for functools32 21:59:58 INFO - warning: no files found matching '*.txt' 21:59:58 INFO - no previously-included directories found matching 'build' 21:59:58 INFO - no previously-included directories found matching 'dist' 21:59:58 INFO - no previously-included directories found matching '.git*' 21:59:58 INFO - Successfully installed jsonschema functools32 21:59:58 INFO - Cleaning up... 21:59:58 INFO - Return code: 0 21:59:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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', '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 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 21:59: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:59: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 functools32==3.2.3-2 21:59:58 INFO - Using env: {'DISPLAY': ':0', 21:59:58 INFO - 'HOME': '/home/cltbld', 21:59:58 INFO - 'LANG': 'en_US.UTF-8', 21:59:58 INFO - 'LANGUAGE': 'en_US:en', 21:59:58 INFO - 'LOGNAME': 'cltbld', 21:59:58 INFO - 'MAIL': '/var/mail/cltbld', 21:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:58 INFO - 'MOZ_NO_REMOTE': '1', 21:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:58 INFO - 'NO_EM_RESTART': '1', 21:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:58 INFO - 'PWD': '/builds/slave/test', 21:59:58 INFO - 'SHELL': '/bin/bash', 21:59:58 INFO - 'SHLVL': '1', 21:59:58 INFO - 'TERM': 'linux', 21:59:58 INFO - 'TMOUT': '86400', 21:59:58 INFO - 'USER': 'cltbld', 21:59:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 21:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:58 INFO - '_': '/tools/buildbot/bin/python'} 21:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:59:59 INFO - Cleaning up... 21:59:59 INFO - Return code: 0 21:59:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:59:59 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')]} 21:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:59 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')]} 21:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:59 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 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 21:59:59 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 21:59:59 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 21:59:59 INFO - Using env: {'DISPLAY': ':0', 21:59:59 INFO - 'HOME': '/home/cltbld', 21:59:59 INFO - 'LANG': 'en_US.UTF-8', 21:59:59 INFO - 'LANGUAGE': 'en_US:en', 21:59:59 INFO - 'LOGNAME': 'cltbld', 21:59:59 INFO - 'MAIL': '/var/mail/cltbld', 21:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:59 INFO - 'MOZ_NO_REMOTE': '1', 21:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:59 INFO - 'NO_EM_RESTART': '1', 21:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:59 INFO - 'PWD': '/builds/slave/test', 21:59:59 INFO - 'SHELL': '/bin/bash', 21:59:59 INFO - 'SHLVL': '1', 21:59:59 INFO - 'TERM': 'linux', 21:59:59 INFO - 'TMOUT': '86400', 21:59:59 INFO - 'USER': 'cltbld', 21:59:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 21:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:59 INFO - '_': '/tools/buildbot/bin/python'} 21:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:59 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:01 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:00:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - Downloading docopt-0.6.1.tar.gz 22:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:02 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:02 INFO - Running setup.py install for blobuploader 22:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:00:02 INFO - Running setup.py install for requests 22:00:02 INFO - Running setup.py install for docopt 22:00:02 INFO - Successfully installed blobuploader requests docopt 22:00:02 INFO - Cleaning up... 22:00:02 INFO - Return code: 0 22:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:02 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')]} 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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')]} 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 22:00:02 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 22:00:02 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 22:00:02 INFO - Using env: {'DISPLAY': ':0', 22:00:02 INFO - 'HOME': '/home/cltbld', 22:00:02 INFO - 'LANG': 'en_US.UTF-8', 22:00:02 INFO - 'LANGUAGE': 'en_US:en', 22:00:02 INFO - 'LOGNAME': 'cltbld', 22:00:02 INFO - 'MAIL': '/var/mail/cltbld', 22:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:02 INFO - 'MOZ_NO_REMOTE': '1', 22:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:02 INFO - 'NO_EM_RESTART': '1', 22:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:02 INFO - 'PWD': '/builds/slave/test', 22:00:02 INFO - 'SHELL': '/bin/bash', 22:00:02 INFO - 'SHLVL': '1', 22:00:02 INFO - 'TERM': 'linux', 22:00:02 INFO - 'TMOUT': '86400', 22:00:02 INFO - 'USER': 'cltbld', 22:00:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 22:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:02 INFO - '_': '/tools/buildbot/bin/python'} 22:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:02 INFO - Running setup.py (path:/tmp/pip-kfTwEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:03 INFO - Running setup.py (path:/tmp/pip-KegMje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:03 INFO - Running setup.py (path:/tmp/pip-d08Wzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:03 INFO - Running setup.py (path:/tmp/pip-dYv5hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:03 INFO - Running setup.py (path:/tmp/pip-RDdyBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:03 INFO - Running setup.py (path:/tmp/pip-qipeB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:03 INFO - Running setup.py (path:/tmp/pip-1g9jMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:03 INFO - Running setup.py (path:/tmp/pip-WF6iGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:03 INFO - Running setup.py (path:/tmp/pip-qxeBSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:03 INFO - Running setup.py (path:/tmp/pip-yfaklf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:03 INFO - Running setup.py (path:/tmp/pip-A7eWjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:03 INFO - Running setup.py (path:/tmp/pip-l_hCHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:03 INFO - Running setup.py (path:/tmp/pip-FCyeUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:03 INFO - Running setup.py (path:/tmp/pip-X9wS6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:03 INFO - Running setup.py (path:/tmp/pip-4SBcu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:04 INFO - Running setup.py (path:/tmp/pip-ZFBKyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:04 INFO - Running setup.py (path:/tmp/pip-0BtpSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:04 INFO - Running setup.py install for manifestparser 22:00:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Running setup.py install for mozcrash 22:00:04 INFO - Running setup.py install for mozdebug 22:00:04 INFO - Running setup.py install for mozdevice 22:00:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Running setup.py install for mozfile 22:00:04 INFO - Running setup.py install for mozhttpd 22:00:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Running setup.py install for mozinfo 22:00:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Running setup.py install for mozInstall 22:00:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Running setup.py install for mozleak 22:00:05 INFO - Running setup.py install for mozlog 22:00:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:00:05 INFO - Running setup.py install for moznetwork 22:00:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:00:05 INFO - Running setup.py install for mozprocess 22:00:05 INFO - Running setup.py install for mozprofile 22:00:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:00:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:00:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:00:05 INFO - Running setup.py install for mozrunner 22:00:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:00:05 INFO - Running setup.py install for mozscreenshot 22:00:05 INFO - Running setup.py install for moztest 22:00:05 INFO - Running setup.py install for mozversion 22:00:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:00:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:05 INFO - Cleaning up... 22:00:05 INFO - Return code: 0 22:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:05 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')]} 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:05 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')]} 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:05 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 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 22:00:05 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 22:00:05 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 22:00:05 INFO - Using env: {'DISPLAY': ':0', 22:00:05 INFO - 'HOME': '/home/cltbld', 22:00:05 INFO - 'LANG': 'en_US.UTF-8', 22:00:05 INFO - 'LANGUAGE': 'en_US:en', 22:00:05 INFO - 'LOGNAME': 'cltbld', 22:00:05 INFO - 'MAIL': '/var/mail/cltbld', 22:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:05 INFO - 'MOZ_NO_REMOTE': '1', 22:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:05 INFO - 'NO_EM_RESTART': '1', 22:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:05 INFO - 'PWD': '/builds/slave/test', 22:00:05 INFO - 'SHELL': '/bin/bash', 22:00:05 INFO - 'SHLVL': '1', 22:00:05 INFO - 'TERM': 'linux', 22:00:05 INFO - 'TMOUT': '86400', 22:00:05 INFO - 'USER': 'cltbld', 22:00:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 22:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:05 INFO - '_': '/tools/buildbot/bin/python'} 22:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:06 INFO - Running setup.py (path:/tmp/pip-MZh7YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:06 INFO - Running setup.py (path:/tmp/pip-YSbCV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:06 INFO - Running setup.py (path:/tmp/pip-axv0Rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:06 INFO - Running setup.py (path:/tmp/pip-WWY2SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:06 INFO - Running setup.py (path:/tmp/pip-j21NSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:06 INFO - Running setup.py (path:/tmp/pip-lram3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:06 INFO - Running setup.py (path:/tmp/pip-CWABcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:06 INFO - Running setup.py (path:/tmp/pip-0i_oly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:06 INFO - Running setup.py (path:/tmp/pip-TRVWgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:06 INFO - Running setup.py (path:/tmp/pip-lKjEsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:06 INFO - Running setup.py (path:/tmp/pip-sBKB9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:06 INFO - Running setup.py (path:/tmp/pip-xmI7v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:07 INFO - Running setup.py (path:/tmp/pip-R6SQ3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:07 INFO - Running setup.py (path:/tmp/pip-3pKcFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:07 INFO - Running setup.py (path:/tmp/pip-_78uUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:07 INFO - Running setup.py (path:/tmp/pip-OXU3Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:07 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)) 22:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:07 INFO - Running setup.py (path:/tmp/pip-477WH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:09 INFO - Downloading blessings-1.6.tar.gz 22:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:09 INFO - Installing collected packages: blessings 22:00:09 INFO - Running setup.py install for blessings 22:00:09 INFO - Successfully installed blessings 22:00:09 INFO - Cleaning up... 22:00:09 INFO - Return code: 0 22:00:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:09 INFO - Reading from file tmpfile_stdout 22:00:09 INFO - Current package versions: 22:00:09 INFO - argparse == 1.2.1 22:00:09 INFO - blessings == 1.6 22:00:09 INFO - blobuploader == 1.2.4 22:00:09 INFO - docopt == 0.6.1 22:00:09 INFO - functools32 == 3.2.3-2 22:00:09 INFO - jsonschema == 2.5.1 22:00:09 INFO - manifestparser == 1.1 22:00:09 INFO - mozInstall == 1.12 22:00:09 INFO - mozcrash == 0.17 22:00:09 INFO - mozdebug == 0.1 22:00:09 INFO - mozdevice == 0.48 22:00:09 INFO - mozfile == 1.2 22:00:09 INFO - mozhttpd == 0.7 22:00:09 INFO - mozinfo == 0.9 22:00:09 INFO - mozleak == 0.1 22:00:09 INFO - mozlog == 3.4 22:00:09 INFO - moznetwork == 0.27 22:00:09 INFO - mozprocess == 0.23 22:00:09 INFO - mozprofile == 0.28 22:00:09 INFO - mozrunner == 6.12 22:00:09 INFO - mozscreenshot == 0.1 22:00:09 INFO - mozsystemmonitor == 0.3 22:00:09 INFO - moztest == 0.7 22:00:09 INFO - mozversion == 1.4 22:00:09 INFO - psutil == 3.1.1 22:00:09 INFO - requests == 1.2.3 22:00:09 INFO - wsgiref == 0.1.2 22:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:09 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 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 22:00:09 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 22:00:09 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 22:00:09 INFO - Using env: {'DISPLAY': ':0', 22:00:09 INFO - 'HOME': '/home/cltbld', 22:00:09 INFO - 'LANG': 'en_US.UTF-8', 22:00:09 INFO - 'LANGUAGE': 'en_US:en', 22:00:09 INFO - 'LOGNAME': 'cltbld', 22:00:09 INFO - 'MAIL': '/var/mail/cltbld', 22:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:09 INFO - 'MOZ_NO_REMOTE': '1', 22:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:09 INFO - 'NO_EM_RESTART': '1', 22:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:09 INFO - 'PWD': '/builds/slave/test', 22:00:09 INFO - 'SHELL': '/bin/bash', 22:00:09 INFO - 'SHLVL': '1', 22:00:09 INFO - 'TERM': 'linux', 22:00:09 INFO - 'TMOUT': '86400', 22:00:09 INFO - 'USER': 'cltbld', 22:00:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 22:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:09 INFO - '_': '/tools/buildbot/bin/python'} 22:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 INFO - Cleaning up... 22:00:09 INFO - Return code: 0 22:00:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f805fb65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', '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 22:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:00:10 INFO - Using env: {'DISPLAY': ':0', 22:00:10 INFO - 'HOME': '/home/cltbld', 22:00:10 INFO - 'LANG': 'en_US.UTF-8', 22:00:10 INFO - 'LANGUAGE': 'en_US:en', 22:00:10 INFO - 'LOGNAME': 'cltbld', 22:00:10 INFO - 'MAIL': '/var/mail/cltbld', 22:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:10 INFO - 'MOZ_NO_REMOTE': '1', 22:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:10 INFO - 'NO_EM_RESTART': '1', 22:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:10 INFO - 'PWD': '/builds/slave/test', 22:00:10 INFO - 'SHELL': '/bin/bash', 22:00:10 INFO - 'SHLVL': '1', 22:00:10 INFO - 'TERM': 'linux', 22:00:10 INFO - 'TMOUT': '86400', 22:00:10 INFO - 'USER': 'cltbld', 22:00:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 22:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:10 INFO - '_': '/tools/buildbot/bin/python'} 22:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:00:10 INFO - Cleaning up... 22:00:10 INFO - Return code: 0 22:00:10 INFO - Running post-action listener: _resource_record_post_action 22:00:10 INFO - Running post-action listener: _start_resource_monitoring 22:00:10 INFO - Starting resource monitoring. 22:00:10 INFO - [mozharness: 2016-10-08 05:00:10.265518Z] Finished create-virtualenv step (success) 22:00:10 INFO - [mozharness: 2016-10-08 05:00:10.265979Z] Running install step. 22:00:10 INFO - Running pre-action listener: _resource_record_pre_action 22:00:10 INFO - Running main action method: install 22:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:10 INFO - Reading from file tmpfile_stdout 22:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:00:10 INFO - Reading from file tmpfile_stdout 22:00:10 INFO - Output received: 22:00:10 INFO - Usage: mozinstall [options] installer 22:00:10 INFO - Options: 22:00:10 INFO - -h, --help show this help message and exit 22:00:10 INFO - -d DEST, --destination=DEST 22:00:10 INFO - Directory to install application into. [default: 22:00:10 INFO - "/builds/slave/test"] 22:00:10 INFO - --app=APP Application being installed. [default: firefox] 22:00:10 INFO - mkdir: /builds/slave/test/build/application 22:00:10 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'] 22:00:10 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 22:00:27 INFO - Reading from file tmpfile_stdout 22:00:27 INFO - Output received: 22:00:27 INFO - /builds/slave/test/build/application/firefox/firefox 22:00:27 INFO - Running post-action listener: _resource_record_post_action 22:00:27 INFO - [mozharness: 2016-10-08 05:00:27.595377Z] Finished install step (success) 22:00:27 INFO - [mozharness: 2016-10-08 05:00:27.595651Z] Running run-tests step. 22:00:27 INFO - Running pre-action listener: _resource_record_pre_action 22:00:27 INFO - Running main action method: run_tests 22:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:27 INFO - Python 2.7.3 22:00:27 INFO - Return code: 0 22:00:27 INFO - grabbing minidump binary from tooltool 22:00:27 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')]} 22:00:27 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 0x186a930>, '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 0x186b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186bcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:27 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 22:00:27 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 22:00:27 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 22:00:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:27 INFO - Return code: 0 22:00:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:00:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:00:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 22:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 22:00:27 INFO - Using env: {'DISPLAY': ':0', 22:00:27 INFO - 'HOME': '/home/cltbld', 22:00:27 INFO - 'LANG': 'en_US.UTF-8', 22:00:27 INFO - 'LANGUAGE': 'en_US:en', 22:00:27 INFO - 'LOGNAME': 'cltbld', 22:00:27 INFO - 'MAIL': '/var/mail/cltbld', 22:00:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:27 INFO - 'MOZ_NO_REMOTE': '1', 22:00:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:27 INFO - 'NO_EM_RESTART': '1', 22:00:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:27 INFO - 'PWD': '/builds/slave/test', 22:00:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:27 INFO - 'SHELL': '/bin/bash', 22:00:27 INFO - 'SHLVL': '1', 22:00:27 INFO - 'TERM': 'linux', 22:00:27 INFO - 'TMOUT': '86400', 22:00:27 INFO - 'USER': 'cltbld', 22:00:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232', 22:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:27 INFO - '_': '/tools/buildbot/bin/python'} 22:00:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 22:00:27 INFO - mozversion application_buildid: 20161007183007 22:00:27 INFO - mozversion application_changeset: 5c67c91fc9cac4f3df0f4dd85b6d6c8cb3140fa3 22:00:27 INFO - mozversion application_display_name: Nightly 22:00:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:27 INFO - mozversion application_name: Firefox 22:00:27 INFO - mozversion application_remotingname: firefox 22:00:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:00:27 INFO - mozversion application_vendor: Mozilla 22:00:27 INFO - mozversion application_version: 52.0a1 22:00:27 INFO - mozversion platform_buildid: 20161007183007 22:00:27 INFO - mozversion platform_changeset: 5c67c91fc9cac4f3df0f4dd85b6d6c8cb3140fa3 22:00:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:00:27 INFO - mozversion platform_version: 52.0a1 22:00:27 INFO - using testdate: 1475902827 22:00:27 INFO - actual date: 1475902827 22:00:27 INFO - starting webserver on 'localhost:58515' 22:00:27 INFO - SUITE-START | Running 2 tests 22:00:27 INFO - TEST-START | dromaeo_css 22:00:27 INFO - operating with platform_type : linux_ 22:00:27 INFO - Initialising browser for dromaeo_css test... 22:00:27 INFO - TEST-INFO | started process 2917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEgJIp/profile http://localhost:58515/getInfo.html) 22:00:32 INFO - PROCESS | 2917 | __metrics Screen width/height:1600/1200 22:00:32 INFO - PROCESS | 2917 | colorDepth:24 22:00:32 INFO - PROCESS | 2917 | Browser inner width/height: 1024/697 22:00:32 INFO - PROCESS | 2917 | __metrics 22:00:32 INFO - PROCESS | 2917 | 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" 22:00:32 INFO - PROCESS | 2917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:33 INFO - PROCESS | 2917 | console.error: PushService: 22:00:33 INFO - PROCESS | 2917 | stateChangeProcessEnqueue: Error transitioning state 22:00:33 INFO - PROCESS | 2917 | UnknownError 22:00:34 INFO - TEST-INFO | 2917: exit 0 22:00:34 INFO - Browser initialized. 22:00:34 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:34 INFO - TEST-INFO | started process 3005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEgJIp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:46 INFO - PROCESS | 3005 | RSS: Main: 173105152 22:00:46 INFO - PROCESS | 3005 | 22:01:37 INFO - PROCESS | 3005 | 1475902897168 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] 22:03:48 INFO - PROCESS | 3005 | Cycle 1(1): loaded http://localhost:58515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58515/tests/dromaeo/cssquery-ext.html) 22:03:49 INFO - PROCESS | 3005 | RSS: Main: 285130752 22:03:49 INFO - PROCESS | 3005 | 22:06:52 INFO - PROCESS | 3005 | Cycle 1(1): loaded http://localhost:58515/tests/dromaeo/cssquery-ext.html (next: http://localhost:58515/tests/dromaeo/cssquery-jquery.html) 22:06:52 INFO - PROCESS | 3005 | RSS: Main: 279097344 22:06:52 INFO - PROCESS | 3005 | 22:09:54 INFO - PROCESS | 3005 | Cycle 1(1): loaded http://localhost:58515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58515/tests/dromaeo/cssquery-mootools.html) 22:09:55 INFO - PROCESS | 3005 | RSS: Main: 214523904 22:09:55 INFO - PROCESS | 3005 | 22:12:57 INFO - PROCESS | 3005 | Cycle 1(1): loaded http://localhost:58515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58515/tests/dromaeo/cssquery-prototype.html) 22:12:58 INFO - PROCESS | 3005 | RSS: Main: 267554816 22:12:58 INFO - PROCESS | 3005 | 22:16:00 INFO - PROCESS | 3005 | Cycle 1(1): loaded http://localhost:58515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58515/tests/dromaeo/cssquery-yui.html) 22:16:01 INFO - PROCESS | 3005 | RSS: Main: 214589440 22:16:01 INFO - PROCESS | 3005 | 22:19:04 INFO - PROCESS | 3005 | Cycle 1(1): loaded http://localhost:58515/tests/dromaeo/cssquery-yui.html (next: http://localhost:58515/tests/dromaeo/cssquery-dojo.html) 22:19:04 INFO - PROCESS | 3005 | RSS: Main: 311664640 22:19:04 INFO - PROCESS | 3005 | 22:19:04 INFO - PROCESS | 3005 | __start_tp_report 22:19:04 INFO - PROCESS | 3005 | _x_x_mozilla_page_load 22:19:04 INFO - PROCESS | 3005 | _x_x_mozilla_page_load_details 22:19:04 INFO - PROCESS | 3005 | |i|pagename|runs| 22:19:04 INFO - PROCESS | 3005 | |0;dojo.html;3019.9999999999995;3058.8011779234334;3060.143159915224;3090.196548897286;3113.7508999280058;5076.771545280462;5180.533751962323;5237.8690532736655;5254.343207099113;5275.393329767083;5206.609504287175;5226.05930932433;5227.660202086861;5233.424323324441;5239.240310155025;4672.322513235587;4773.379460670108;4873.439554451248;4904.068227036852;4937.6790508617005;4794.712317260958;4799.400074990626;4801.399825021872;4864.075825593126;4867;4814.1334559779225;4904.117258893398;4906.141425250585;4947.876303092416;4958.652894297401;4853.39332583427;4896.1186986342445;4906.484819093979;4940.876478088041;4955.331030310898;4677.368555245032;4681.180793361183;4747.192977193851;4747.810087596492;4876.049170411771;5244.632875698702;5261.316028916254;5285.6300058995885;5306.73466326686;5355.678659280456;5685.545156387479;5689.743961521742;5700.116481945305;5723.856903577403;5746.051901436258;5578.274824272859;5637.8590535236945;5696.2594862668;5717.48542631161;5725.2843394575675;5271.683698978035;5311.5750739941095;5350.411454739976;5390.54180394663;5406.91889621656;5888.764449422061;5891.1752354669525;5899.292084949833;5899.557533184942;5900.468957793733;5417.458254174551;5461.044317244467;5653.378128405872;5655.123455864347;5659.773609055592;5501.477359650827;5634.408387119375;5686.402927692533;5725.656460612293;5797.8550536236935;5678.801241956512;5707.143928410772;5710.200571919934;5717.571182161355;5785.71071446426;5567.582431317667;5670.858228544319;5706.828795136153;5717.199592057115;5724.227229324071;4384;4394.692371533962;4434.246178149722;4439.64482841372;4444.2222611042935;3961.2275606256503;3962.2075584883137;3994.6205110514456;3996.620321069494;4001.0597509585223;5444.156155795858;5451.972740136274;5462.6449280797415;5464.726763661881;5497.862553436116;5587.106063029895;5764.798232061858;5770.278715160605;5781.797637082682;5786.334571524244;5296.390915044819;5355.812546560929;5420.322459692538;5427.6472029317965;5504.697241651667;4987.226979818134;4989.700617962933;4994.850154495371;5004.774785134678;5064.82273120439;5689.971550142222;5904.704764761745;5908.734106965283;5914.0537513998415;5919.4080591940465;5588;5591.18927755465;5646.322441307069;5654.349749778664;5752.827415177551;5752.252207213036;5796.275465566804;5796.913046304225;5797.043487824461;5803.187553742395;5536.667799932017;5579.804706835242;5580.051391263576;5588.077967135378;5595.244641973444;5623.268975033219;5661.094224923992;5670.5180059695385;5684.459976302244;5729.627574207663;5594.496495315441;5602.971985140048;5607.43925607436;5608.635438696635;5665.235193248858;5507.807226747044;5559.944400555943;5563.972180139073;5570.91643625354;5594.636348637326;5347.572194224531;5407.242985982044;5416.945830541802;5430.212619170277;5548.528375088163;5566.582506312124;5615.6630602164005;5616.691081990366;5676.063449530781;5690.800821971211;5432.483914028161;5473.890522189614;5480.177973304037;5480.698561579152;5563.638363506359 22:19:04 INFO - PROCESS | 3005 | |1;ext.html;558.5756321380479;593.2643522032679;615.5844804756788;623.2334228898452;637.3881074168797;30984.53523197151;31830.522542161856;46547.76726116369;46787.76606116973;46968.295475567895;44421.111577768424;44838.775806120924;44861;44985;45011;8807.207351338378;9008;9015.413998090136;9015.594298256594;9017.23353514952;8762.737117886474;8847.159519845605;8848.778780530505;8855.247303979137;8859.645614175426;8855.380123391365;8898.777530561756;8904.59929303183;8908.955455222715;8908.955455222747;8820.779480512974;8849.911500884973;8857.158569935846;8857.379983401164;8857.822843543125;8725.781855453664;8799.428037177628;8817.206451419339;8822.558872056372;8826.338024648177;42553;42765.57234427647;42876;42876.57123428757;42919.14161716748;3554.3957527220437;3556.8043757593323;3741.363968125398;4109.815058322382;4120.1553681495525;31024.37951240985;31291.217719556964;31964;32014.19964500883;32699.6730032699;4239.342901850218;4289.356596510517;4312;4325.156594464081;4330.112326972963;352687;353211;355934;357089;358154;57133.42866571281;57372;57611;57648.42351576514;57733.711331443075;36231.27537449236;37043.96164728747;37058.25883482315;39272.41091383631;39304.41043384351;17531.211095500734;17720.379786707403;17740.379086731904;17741.55646108832;17761.911190443963;13665;13846.861531384759;13859.861401385857;13861.653458663412;13862.722745545032;18854;19029;19064;19070.61858762817;19091.713624295648;7113.82215444618;7135.714571417086;7213.531120477152;7227.205007449176;7436.73971410998;906.9365144439826;981.293468702533;988.7132731507783;1033.540074666781;1037.3205550364523;30896.53655195174;30988.69011309903;31326.216844578612;31345.686543134732;31970;1068.1081297116993;1075.1506310015156;1086.706589220906;1103.089950790601;1149.3161568866678;16112.677746445006;16839.662111009206;16903.746443803353;16973.49079527616;17296.654066918843;146488.26755866152;147193;147360.26319868545;148293;148605;56750.7162464185;57341;57423.425765741806;57452.42547574554;57528.42471575314;1212.5028738217288;1270.1426537087614;1314.1523717202351;1314.9605511834661;1338.1302153600238;29351.559726604544;32672;32960.1759956003;33102.33795324128;33353.499697505045;49976.500234997184;53654.73172634268;55050;55306.72346638241;60819.69590152021;507472;512346;512682;513833;516777;34096;35337.63922493873;41742;43497.34753978756;43745.56254437415;46837.76581117073;46994.53005469902;47166.52833471759;47173;47260;38644.420333694456;39375;39421.408678869266;39950.40074398944;41288;39370.803145984086;39708;40005.79997099996;40257.79871100626;41577.58422415858;40082;40134.79932600435;40195.79902100471;40815.38776918408;40846.79576602098;33779.831100845324;36048.639513604525;36116.63883361133;36649;36986;26605.600915985888;27097.322566935985;27147;27352.863235683693;27683.58474622842 22:19:04 INFO - PROCESS | 3005 | |2;jquery.html;401.6544575671501;403.650842021651;409.6231467050314;413.31596208275295;428.6270944278476;13556;18186.454406367797;18906.43280701578;19901;19990.400287991346;14927.776083358758;15417.460388886391;17842.10789460525;17992.370267040624;18253.45239642813;5405.702686352249;5780.50865676418;5804.622699524539;5806.10005449154;5806.129080637917;5622.156676498517;5774.913376299359;5853.414658534155;5865.413458654122;5870.0314448116005;5767.279090113736;5781.190633311318;5807.535397168216;5812.215350927634;5816.098504731774;5556.416576259475;5747.195392645033;5755.2805899262385;5766.250387449647;5773.105168698838;5651.519620832234;5659;5673.886522269573;5713.200151978726;5726.3414707308775;13618.455261789517;20023.599528009505;22136.557268854533;22229.55540889173;22335.10659573615;2054.7431571053617;2184.7050648162613;2366.810655147584;2413.698287714036;2741.424300896814;9552.522373881347;9835.114839664393;10122.949385253027;10292.228082893813;10359.32664376813;1875.6998880179242;1920.898340455141;1937.5156210947264;1953.4042117154263;1982.5043739065234;81697;81959;82660.58669706613;87881;91007.08992910052;10825.621103261348;10875.238733288752;11052.060574851228;11155.832662510069;11228.27016243958;15655.138967356905;15688.058716477048;15738.449154279546;15805.52583422499;15808.209589520708;7286.927130728731;7595.5442673438665;7738.845223095506;7948.767940969159;8193.71322003727;7468.327850493373;7490.400767938552;7618;7679.385649148055;7728.574928378993;4694.131585656664;4721.5278472153195;4828.565429111327;4887.193613053806;4909.631777616622;1822.2670942708974;1823.8075199881343;1937.98062019378;2041.9489512762002;2101.3065688322818;871.9171678690515;914.7895983923735;925.9490728009889;949.2832911152174;1021.3820638513592;17119;18115.54711132232;18454;18532.536686582673;18887;904.2404380320562;966.0387914025589;972.0473935543207;979.7011911366959;984.4044353166231;8119.594020298961;9954.800903981879;10351.06840384369;10555.736106597244;10607.946960265304;486149;494900;495147;498669;512618;92842.53578732198;94724;95929.52035239918;97485.51257243668;98359.01640983642;954.6610953111684;976.1312431935582;1029.361795686679;1029.7837454134565;1030.314840630987;15926.362945482515;16242.187890605659;17276.740848887024;17395.91302043482;17408.541722418922;43447.34828977631;43790.12419751651;44305.33541996937;44727;45595.54404455913;59575.702121489114;60692.10381059971;60924.69537652283;62012;63452.365476346495;8244.628991695508;8319.542425166674;8341.833163336578;8348.666053357798;8353.665853365797;12493.812592810933;12648;12798.360081995677;12891.548795792478;12898.226106433269;10691.679249622524;11322.716932076764;11354;11613.6515904523;11623.56092101039;10918.508667110158;11225.550977960791;11248;11281.266717663326;11526.827097593376;11334.773304534028;11405.714857128638;11418;11465.254758440675;11836.349000804694;7242.13094428672;7638.50349727266;8501.277391421798;8507.914920850711;9006.279497640042;10043.246756493147;10583.782864970626;10640.787184256425;10820.268756998843;11733.471993760131 22:19:04 INFO - PROCESS | 3005 | |3;mootools.html;1484.7179035983158;1530.2501774130676;1629.8859079864408;1735.0804073840868;1801.0094448053567;8035.357171426286;8315.126911674277;8584.141585841413;9267.721968340944;9307.069293070697;8565;8901.376903616734;8928.821423571524;9192.402493837913;9207.401518901266;2393.2700526339504;2418.5404773093146;2421.6730741349957;2422.648715936197;2426.7502236348296;1989.661757501221;2051.148773259103;2412.8552286862846;2413.372523143986;2429.0405289910564;2298.1726578431753;2374.169040835702;2374.798142157919;2380.571816746926;2389.940251493718;2326.069572171128;2352.270796053212;2390.748971358;2428.890699918508;2429.5748244057218;2334.4163959010248;2354.9411264718347;2362.5511152881068;2364.9054037838464;2379.5003049359484;9118.680846170419;9144.8628270576;9203.723888283363;9222.216111630452;9234.953825230898;5288.735563221862;5415.431379705114;5422.43064478232;5432.320959880015;5457.699826509541;3378.45944648855;3466.670666286724;3497.877574284888;3506.8421921013614;3551.200979779555;1122.360254654847;1164.598213616301;1176.7293522489874;1191.023360844108;1201.0571701214592;12832.422540985584;12928.741425171538;12972.481100755958;12974.026947978846;12980.480780768758;4765.404324459442;4765.69023013503;4784;4830.903381932341;4967.081089998362;10673.092787113183;10705.732356690989;10708.73228169302;10714.303570267908;10719.624813131659;5180.585553155738;5203.635745497779;5208;5210.114280572312;5212.139996900469;4698.765061746967;4753.215719406328;4755.310479980383;4762.476127625959;4838.104950584153;3977.3039718049226;4002.8598999035476;4089.8568550100604;4137.482814648169;4160.729552579072;1239.975200495985;1269.2638269803492;1291.1478424239956;1325.2114991579995;1333.2667033131738;808.3412019204329;873.5457562067817;885.8051228729669;893.5666201892077;913.2785099771239;5475.534579560703;5482.91775623366;5533.723313834373;5571.526420254324;5764.221830052973;856.7943693513512;862.9784255393665;884.2351366068305;918.9218916392048;934.7382732834817;3649.50731651229;3713.350163721338;3768.9516329472913;3822.1782316802023;3861.131245469747;10511.316764410289;10729.678109656723;11391.715207119889;11395.746467888526;11403;10960.068394186583;11020.614278500374;11063.778724425467;11065.612703555336;11068.612598559012;8084.474509156886;8227.095019547845;8231.259186673227;8280.917190828015;8433.873491897626;5618.7190640467;5627.803026894039;5785.913211301918;5787.7395517200985;5791.594588378942;9853;9882.25883058759;9990.450525221182;10091.19270458347;10302.536385862804;10115.291929564859;10215.693529194135;10534.315269507457;10723.410212438392;10782.299150555189;7617.085949686073;7698.114716807639;7763.68945242184;7896.6446509906045;7941.682332706858;8453.239208471266;8595.570221488775;8598.699045533627;8600.870986935326;8609.053004169662;7494.288042635941;7637.427192960439;7682.423818213544;7725.343345815669;8026.83946321082;7661.885071723817;7685.193054729173;7776.377889768918;7786.961065194638;8041.155678653658;6694.866102677822;6792.660366981532;6798.422134118655;6808.489363297674;6809.455243580403;4635.65232607549;4808.567228949411;4817.156997525489;4858.708477491362;4883.047805678001;4828.396450443694;4841.491643377394;4914.287428322802;4937.777799998937;5132.7433628317685 22:19:04 INFO - PROCESS | 3005 | |4;prototype.html;328.6810117242337;335.2958786548249;341.66687479707304;342.14122552393485;342.29316461507;5287.048331300369;5309.8938021239555;5322.547583455401;5333.626646134772;5375.704336261514;5262;5270.9736451317785;5276.868078298035;5289.973550132254;5304.840854774353;4145.626893579577;4156.064885400783;4187.769672668002;4191.706580539363;4217.894552636178;3854.383298672213;3939.940900886489;4097.569755175708;4138.461999940018;4141.254574176647;4110.23960567296;4123.484564429446;4123.8350465981475;4136.917261654765;4136.958630413703;4121.866486716147;4127.2570937231285;4129.607687269705;4140.171965606891;4144.378343248507;3474;3478.7564870459078;3611.56661200655;3618.2763447310645;3659.9451008234896;5091.134507133759;5103.8468845934685;5108.445777111444;5122.154844450662;5142.305788718512;4728.432588089417;4737.218358970766;4737.620990320766;4745.528886045303;4750.334953106568;5384.3538775346815;5390.865228369322;5427.755750991215;5453.372862120827;5471.398146203915;4018.45750823638;4023.5574086850424;4040.8583450770843;4057.1885622875543;4066.8983275418054;5635.408282130399;5722.942770572325;5728.283964504437;5735.254416925773;5736.627119237236;4075.836966521306;4100.487439070116;4102.2000709861295;4105.363668631367;4118.691098167589;4163.604457576525;4187.14163596462;4198.370244463294;4209.284421648327;4211.599898009684;4756.167670657621;4760.523947605212;4761.738104404291;4762.166620841408;4789.233722604366;5323.547498462674;5444.156155795858;5489.39616642169;5502.394736578973;5566.471185237396;1431.3487363249697;1445.7205373244753;1447.3052934591456;1448.2107251547932;1448.7826825976188;989.2086330935223;1016.6848277034143;1025.466757286207;1031.3708637730979;1037.3827572594446;5144.9742751286;5269.894602107936;5281.973590132025;5286.326003427581;5297.496737809902;5525.1214587040595;5552.888942221133;5680.8863822723315;5685.630434021776;5716.485516303553;5374.044275648378;5383.569314454834;5383.650062745909;5385.165299378603;5416.350037995466;2884.7259510346485;2990.2524368907775;2998.415309014721;2998.625171853518;3011.2471882029495;5826.912596311059;5829.8251052468495;5830.970845145747;5832.562557808182;5846.070796637099;5552.611317207757;5803.854903627359;5830.067189249785;5838.32859221195;5839;5803.564732644984;5845.444682755132;5851.239338885917;5856.038227193852;5870.7945221917025;5673.8297851064535;5694.829155125353;5696.601237913306;5703.8859222816145;5743.885122297447;5408.323959505062;5583.776648934159;5614.2701448811395;5654.943450565442;5661;5806.361300257053;5837.6497410155525;5842.824715258549;5845.561582881216;5848.795292164754;4037.4145748866836;4101.528324242631;4110.2601531723385;4117.238310912491;4123.628873401408;5486.61593688438;5701.971490142523;5708.857278568069;5718.999175144416;5770.6249093808765;5559.861003474945;5569.443055694398;5576.665400076008;5577.52591029767;5590.99362114807;5209.889994552213;5547.918155959549;5576.1356989666665;5639.689817060101;5648.774049038157;5401.135818269058;5427.375851777097;5460.426655201147;5466.125419932791;5473.370562385377;5219.556337711185;5493.615446918678;5536.557075433875;5566.944330556643;5567.498925096761;5255.500727430888;5295.735213239245;5418.322709661293;5442.428545002717;5460.31746031746 22:19:04 INFO - PROCESS | 3005 | |5;yui.html;684.8527566573187;724.8151721311065;776.8990031295931;824.5629816197418;828.6312590897053;15957.361705531779;17096.23066961985;17116.229769660364;17126.229319680613;17221.13894305286;14216.573502794907;14891.925540372311;15220.619484512892;15268.923655381735;15418.229088545555;816.6610856494548;838.7609531283586;842.3766412854475;842.9199226073513;843.0431460292551;684.6576711644178;697.8360085379932;815.1725998111921;841.7600983719641;845.733593917917;855.110684887716;857.0529564830865;862.1895418306802;874.4316194473579;874.5059041641452;866.9913300867005;867.6269204242174;868.6351732272461;869.4088020146298;869.752120645613;513.3659929986501;524.0331588219728;621.0373920423326;635.5900444213503;635.9173307470046;14902.180380079091;15180;15240.46658366963;15255.771163432557;15342.769858452131;13412.396442160029;13498.392572334269;13967.65080872976;13999.16005039701;14364.64088397788;12946.223226606433;12965.805512917314;13092.607221783363;13212.405441755049;13654.590362289147;4468.218061839165;4482.820687172509;4522.457305123374;4526.366308716782;4591.83928562502;83469;85524.57237713771;85924;86560.13439865583;87731.56134219289;11608.30350178992;11618.128640352008;11623.12826538013;11625.302481851117;11694.2983420995;22012.559748804935;22075.66886496704;22134.114635414404;22263.666045009337;22279;8298.377621678399;8359.540225287668;8384.958075209706;8424.536650484282;8558.700445484503;4445.575634173224;4525;4544.477385100689;4611.654125940568;4772.6420518461255;3365.848536815849;3468.3063387322636;3473;3473.3227020730715;3473.7047350974944;663.6117871045396;672.2168673495421;673.1551902362504;688.5421194905332;688.5696439725172;582.5223316880202;599.2778701664483;612.7732738886551;619.3280290884351;659.7789740436912;8640.179182977607;8780.341474389446;8803.69187078462;9081.490514502093;9308;566.6486778197544;616.3435940723116;670.7082419147687;672.7376323233942;685.1846302899534;3946.585608511065;4335.934960975588;4338.349247612883;4375.409319741858;4425.336199570091;72154.27845721581;116920;125435.3728231353;125872;130741;64240;78452.2154778445;105799.4710026445;106829;114066;91702.54148729348;93702.53148734213;94029.5298523503;94390;95106;8257.710980115668;8306.293965013041;8320.340609258834;8395.664173432995;8709.520976346363;52177.7391113042;53881.46118538764;54026;55093;57232.42767572271;72088;72843;79870;81367.59316203381;84358.57820710857;11055.72360690989;11538.192326537062;11541.249818761753;11613.941930290295;11629.825552616549;12349.444275007467;12380.62858114258;12399.938000310302;12465.065120115847;12472.376381180724;11633.59282425145;11827.408629568316;11849.644510664693;11981.580644677395;12597.181183223061;12276.263424194576;12971.805422918475;13745.931270343584;13947.30263486842;14010.299485025911;14001.5099471518;14192.432302708188;14272.571822845332;14723.631909202355;15104.622384440478;11283;11350.772984540428;11553.364564949008;11855.98109265691;12952.611421657366;11844.940775296069;12568.74862502763;12723.363831808558;12761.87238127644;12821.487140514648 22:19:04 INFO - PROCESS | 3005 | __end_tp_report 22:19:04 INFO - PROCESS | 3005 | __start_cc_report 22:19:04 INFO - PROCESS | 3005 | _x_x_mozilla_cycle_collect,1018 22:19:04 INFO - PROCESS | 3005 | __end_cc_report 22:19:04 INFO - PROCESS | 3005 | __startTimestamp1475903944399__endTimestamp 22:19:04 INFO - PROCESS | 3005 | 22:19:04 INFO - PROCESS | 3005 | ------- Summary: start ------- 22:19:04 INFO - PROCESS | 3005 | Number of tests: 6 22:19:04 INFO - PROCESS | 3005 | 22:19:04 INFO - PROCESS | 3005 | [#0] dojo.html Cycles:165 Average:5289.71 Median:5480.70 stddev:589.12 (10.7%) stddev-sans-first:563.38 22:19:04 INFO - PROCESS | 3005 | Values: 3020.0 3058.8 3060.1 3090.2 3113.8 5076.8 5180.5 5237.9 5254.3 5275.4 5206.6 5226.1 5227.7 5233.4 5239.2 4672.3 4773.4 4873.4 4904.1 4937.7 4794.7 4799.4 4801.4 4864.1 4867.0 4814.1 4904.1 4906.1 4947.9 4958.7 4853.4 4896.1 4906.5 4940.9 4955.3 4677.4 4681.2 4747.2 4747.8 4876.0 5244.6 5261.3 5285.6 5306.7 5355.7 5685.5 5689.7 5700.1 5723.9 5746.1 5578.3 5637.9 5696.3 5717.5 5725.3 5271.7 5311.6 5350.4 5390.5 5406.9 5888.8 5891.2 5899.3 5899.6 5900.5 5417.5 5461.0 5653.4 5655.1 5659.8 5501.5 5634.4 5686.4 5725.7 5797.9 5678.8 5707.1 5710.2 5717.6 5785.7 5567.6 5670.9 5706.8 5717.2 5724.2 4384.0 4394.7 4434.2 4439.6 4444.2 3961.2 3962.2 3994.6 3996.6 4001.1 5444.2 5452.0 5462.6 5464.7 5497.9 5587.1 5764.8 5770.3 5781.8 5786.3 5296.4 5355.8 5420.3 5427.6 5504.7 4987.2 4989.7 4994.9 5004.8 5064.8 5690.0 5904.7 5908.7 5914.1 5919.4 5588.0 5591.2 5646.3 5654.3 5752.8 5752.3 5796.3 5796.9 5797.0 5803.2 5536.7 5579.8 5580.1 5588.1 5595.2 5623.3 5661.1 5670.5 5684.5 5729.6 5594.5 5603.0 5607.4 5608.6 5665.2 5507.8 5559.9 5564.0 5570.9 5594.6 5347.6 5407.2 5416.9 5430.2 5548.5 5566.6 5615.7 5616.7 5676.1 5690.8 5432.5 5473.9 5480.2 5480.7 5563.6 22:19:04 INFO - PROCESS | 3005 | 22:19:04 INFO - PROCESS | 3005 | [#1] ext.html Cycles:180 Average:51334.46 Median:40831.09 stddev:98588.51 (241.5%) stddev-sans-first:98791.36 22:19:04 INFO - PROCESS | 3005 | Values: 558.6 593.3 615.6 623.2 637.4 30984.5 31830.5 46547.8 46787.8 46968.3 44421.1 44838.8 44861.0 44985.0 45011.0 8807.2 9008.0 9015.4 9015.6 9017.2 8762.7 8847.2 8848.8 8855.2 8859.6 8855.4 8898.8 8904.6 8909.0 8909.0 8820.8 8849.9 8857.2 8857.4 8857.8 8725.8 8799.4 8817.2 8822.6 8826.3 42553.0 42765.6 42876.0 42876.6 42919.1 3554.4 3556.8 3741.4 4109.8 4120.2 31024.4 31291.2 31964.0 32014.2 32699.7 4239.3 4289.4 4312.0 4325.2 4330.1 352687.0 353211.0 355934.0 357089.0 358154.0 57133.4 57372.0 57611.0 57648.4 57733.7 36231.3 37044.0 37058.3 39272.4 39304.4 17531.2 17720.4 17740.4 17741.6 17761.9 13665.0 13846.9 13859.9 13861.7 13862.7 18854.0 19029.0 19064.0 19070.6 19091.7 7113.8 7135.7 7213.5 7227.2 7436.7 906.9 981.3 988.7 1033.5 1037.3 30896.5 30988.7 31326.2 31345.7 31970.0 1068.1 1075.2 1086.7 1103.1 1149.3 16112.7 16839.7 16903.7 16973.5 17296.7 146488.3 147193.0 147360.3 148293.0 148605.0 56750.7 57341.0 57423.4 57452.4 57528.4 1212.5 1270.1 1314.2 1315.0 1338.1 29351.6 32672.0 32960.2 33102.3 33353.5 49976.5 53654.7 55050.0 55306.7 60819.7 507472.0 512346.0 512682.0 513833.0 516777.0 34096.0 35337.6 41742.0 43497.3 43745.6 46837.8 46994.5 47166.5 47173.0 47260.0 38644.4 39375.0 39421.4 39950.4 41288.0 39370.8 39708.0 40005.8 40257.8 41577.6 40082.0 40134.8 40195.8 40815.4 40846.8 33779.8 36048.6 36116.6 36649.0 36986.0 26605.6 27097.3 27147.0 27352.9 27683.6 22:19:04 INFO - PROCESS | 3005 | 22:19:04 INFO - PROCESS | 3005 | [#2] jquery.html Cycles:180 Average:29262.45 Median:43618.74 stddev:82263.49 (188.6%) stddev-sans-first:82465.71 22:19:04 INFO - PROCESS | 3005 | Values: 401.7 403.7 409.6 413.3 428.6 13556.0 18186.5 18906.4 19901.0 19990.4 14927.8 15417.5 17842.1 17992.4 18253.5 5405.7 5780.5 5804.6 5806.1 5806.1 5622.2 5774.9 5853.4 5865.4 5870.0 5767.3 5781.2 5807.5 5812.2 5816.1 5556.4 5747.2 5755.3 5766.3 5773.1 5651.5 5659.0 5673.9 5713.2 5726.3 13618.5 20023.6 22136.6 22229.6 22335.1 2054.7 2184.7 2366.8 2413.7 2741.4 9552.5 9835.1 10122.9 10292.2 10359.3 1875.7 1920.9 1937.5 1953.4 1982.5 81697.0 81959.0 82660.6 87881.0 91007.1 10825.6 10875.2 11052.1 11155.8 11228.3 15655.1 15688.1 15738.4 15805.5 15808.2 7286.9 7595.5 7738.8 7948.8 8193.7 7468.3 7490.4 7618.0 7679.4 7728.6 4694.1 4721.5 4828.6 4887.2 4909.6 1822.3 1823.8 1938.0 2041.9 2101.3 871.9 914.8 925.9 949.3 1021.4 17119.0 18115.5 18454.0 18532.5 18887.0 904.2 966.0 972.0 979.7 984.4 8119.6 9954.8 10351.1 10555.7 10607.9 486149.0 494900.0 495147.0 498669.0 512618.0 92842.5 94724.0 95929.5 97485.5 98359.0 954.7 976.1 1029.4 1029.8 1030.3 15926.4 16242.2 17276.7 17395.9 17408.5 43447.3 43790.1 44305.3 44727.0 45595.5 59575.7 60692.1 60924.7 62012.0 63452.4 8244.6 8319.5 8341.8 8348.7 8353.7 12493.8 12648.0 12798.4 12891.5 12898.2 10691.7 11322.7 11354.0 11613.7 11623.6 10918.5 11225.6 11248.0 11281.3 11526.8 11334.8 11405.7 11418.0 11465.3 11836.3 7242.1 7638.5 8501.3 8507.9 9006.3 10043.2 10583.8 10640.8 10820.3 11733.5 22:19:04 INFO - PROCESS | 3005 | 22:19:04 INFO - PROCESS | 3005 | [#3] mootools.html Cycles:180 Average:5838.20 Median:4812.86 stddev:3385.95 (70.4%) stddev-sans-first:3379.64 22:19:04 INFO - PROCESS | 3005 | Values: 1484.7 1530.3 1629.9 1735.1 1801.0 8035.4 8315.1 8584.1 9267.7 9307.1 8565.0 8901.4 8928.8 9192.4 9207.4 2393.3 2418.5 2421.7 2422.6 2426.8 1989.7 2051.1 2412.9 2413.4 2429.0 2298.2 2374.2 2374.8 2380.6 2389.9 2326.1 2352.3 2390.7 2428.9 2429.6 2334.4 2354.9 2362.6 2364.9 2379.5 9118.7 9144.9 9203.7 9222.2 9235.0 5288.7 5415.4 5422.4 5432.3 5457.7 3378.5 3466.7 3497.9 3506.8 3551.2 1122.4 1164.6 1176.7 1191.0 1201.1 12832.4 12928.7 12972.5 12974.0 12980.5 4765.4 4765.7 4784.0 4830.9 4967.1 10673.1 10705.7 10708.7 10714.3 10719.6 5180.6 5203.6 5208.0 5210.1 5212.1 4698.8 4753.2 4755.3 4762.5 4838.1 3977.3 4002.9 4089.9 4137.5 4160.7 1240.0 1269.3 1291.1 1325.2 1333.3 808.3 873.5 885.8 893.6 913.3 5475.5 5482.9 5533.7 5571.5 5764.2 856.8 863.0 884.2 918.9 934.7 3649.5 3713.4 3769.0 3822.2 3861.1 10511.3 10729.7 11391.7 11395.7 11403.0 10960.1 11020.6 11063.8 11065.6 11068.6 8084.5 8227.1 8231.3 8280.9 8433.9 5618.7 5627.8 5785.9 5787.7 5791.6 9853.0 9882.3 9990.5 10091.2 10302.5 10115.3 10215.7 10534.3 10723.4 10782.3 7617.1 7698.1 7763.7 7896.6 7941.7 8453.2 8595.6 8598.7 8600.9 8609.1 7494.3 7637.4 7682.4 7725.3 8026.8 7661.9 7685.2 7776.4 7787.0 8041.2 6694.9 6792.7 6798.4 6808.5 6809.5 4635.7 4808.6 4817.2 4858.7 4883.0 4828.4 4841.5 4914.3 4937.8 5132.7 22:19:04 INFO - PROCESS | 3005 | 22:19:04 INFO - PROCESS | 3005 | [#4] prototype.html Cycles:180 Average:4666.90 Median:5292.85 stddev:1355.91 (25.6%) stddev-sans-first:1320.04 22:19:04 INFO - PROCESS | 3005 | Values: 328.7 335.3 341.7 342.1 342.3 5287.0 5309.9 5322.5 5333.6 5375.7 5262.0 5271.0 5276.9 5290.0 5304.8 4145.6 4156.1 4187.8 4191.7 4217.9 3854.4 3939.9 4097.6 4138.5 4141.3 4110.2 4123.5 4123.8 4136.9 4137.0 4121.9 4127.3 4129.6 4140.2 4144.4 3474.0 3478.8 3611.6 3618.3 3659.9 5091.1 5103.8 5108.4 5122.2 5142.3 4728.4 4737.2 4737.6 4745.5 4750.3 5384.4 5390.9 5427.8 5453.4 5471.4 4018.5 4023.6 4040.9 4057.2 4066.9 5635.4 5722.9 5728.3 5735.3 5736.6 4075.8 4100.5 4102.2 4105.4 4118.7 4163.6 4187.1 4198.4 4209.3 4211.6 4756.2 4760.5 4761.7 4762.2 4789.2 5323.5 5444.2 5489.4 5502.4 5566.5 1431.3 1445.7 1447.3 1448.2 1448.8 989.2 1016.7 1025.5 1031.4 1037.4 5145.0 5269.9 5282.0 5286.3 5297.5 5525.1 5552.9 5680.9 5685.6 5716.5 5374.0 5383.6 5383.7 5385.2 5416.4 2884.7 2990.3 2998.4 2998.6 3011.2 5826.9 5829.8 5831.0 5832.6 5846.1 5552.6 5803.9 5830.1 5838.3 5839.0 5803.6 5845.4 5851.2 5856.0 5870.8 5673.8 5694.8 5696.6 5703.9 5743.9 5408.3 5583.8 5614.3 5654.9 5661.0 5806.4 5837.6 5842.8 5845.6 5848.8 4037.4 4101.5 4110.3 4117.2 4123.6 5486.6 5702.0 5708.9 5719.0 5770.6 5559.9 5569.4 5576.7 5577.5 5591.0 5209.9 5547.9 5576.1 5639.7 5648.8 5401.1 5427.4 5460.4 5466.1 5473.4 5219.6 5493.6 5536.6 5566.9 5567.5 5255.5 5295.7 5418.3 5442.4 5460.3 22:19:04 INFO - PROCESS | 3005 | 22:19:04 INFO - PROCESS | 3005 | [#5] yui.html Cycles:180 Average:21263.11 Median:4523.73 stddev:31187.94 (689.4%) stddev-sans-first:31237.15 22:19:04 INFO - PROCESS | 3005 | Values: 684.9 724.8 776.9 824.6 828.6 15957.4 17096.2 17116.2 17126.2 17221.1 14216.6 14891.9 15220.6 15268.9 15418.2 816.7 838.8 842.4 842.9 843.0 684.7 697.8 815.2 841.8 845.7 855.1 857.1 862.2 874.4 874.5 867.0 867.6 868.6 869.4 869.8 513.4 524.0 621.0 635.6 635.9 14902.2 15180.0 15240.5 15255.8 15342.8 13412.4 13498.4 13967.7 13999.2 14364.6 12946.2 12965.8 13092.6 13212.4 13654.6 4468.2 4482.8 4522.5 4526.4 4591.8 83469.0 85524.6 85924.0 86560.1 87731.6 11608.3 11618.1 11623.1 11625.3 11694.3 22012.6 22075.7 22134.1 22263.7 22279.0 8298.4 8359.5 8385.0 8424.5 8558.7 4445.6 4525.0 4544.5 4611.7 4772.6 3365.8 3468.3 3473.0 3473.3 3473.7 663.6 672.2 673.2 688.5 688.6 582.5 599.3 612.8 619.3 659.8 8640.2 8780.3 8803.7 9081.5 9308.0 566.6 616.3 670.7 672.7 685.2 3946.6 4335.9 4338.3 4375.4 4425.3 72154.3 116920.0 125435.4 125872.0 130741.0 64240.0 78452.2 105799.5 106829.0 114066.0 91702.5 93702.5 94029.5 94390.0 95106.0 8257.7 8306.3 8320.3 8395.7 8709.5 52177.7 53881.5 54026.0 55093.0 57232.4 72088.0 72843.0 79870.0 81367.6 84358.6 11055.7 11538.2 11541.2 11613.9 11629.8 12349.4 12380.6 12399.9 12465.1 12472.4 11633.6 11827.4 11849.6 11981.6 12597.2 12276.3 12971.8 13745.9 13947.3 14010.3 14001.5 14192.4 14272.6 14723.6 15104.6 11283.0 11350.8 11553.4 11856.0 12952.6 11844.9 12568.7 12723.4 12761.9 12821.5 22:19:04 INFO - PROCESS | 3005 | -------- Summary: end -------- 22:19:04 INFO - PROCESS | 3005 | 22:19:05 INFO - TEST-INFO | 3005: exit 0 22:19:05 INFO - TEST-OK | dromaeo_css | took 1117491ms 22:19:05 INFO - TEST-START | kraken 22:19:05 INFO - operating with platform_type : linux_ 22:19:05 INFO - Initialising browser for kraken test... 22:19:05 INFO - TEST-INFO | started process 3320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmR8lJu/profile http://localhost:58515/getInfo.html) 22:19:09 INFO - PROCESS | 3320 | __metrics Screen width/height:1600/1200 22:19:09 INFO - PROCESS | 3320 | colorDepth:24 22:19:09 INFO - PROCESS | 3320 | Browser inner width/height: 1024/697 22:19:09 INFO - PROCESS | 3320 | __metrics 22:19:10 INFO - PROCESS | 3320 | 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" 22:19:10 INFO - PROCESS | 3320 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:10 INFO - PROCESS | 3320 | console.error: PushService: 22:19:10 INFO - PROCESS | 3320 | stateChangeProcessEnqueue: Error transitioning state 22:19:10 INFO - PROCESS | 3320 | UnknownError 22:19:11 INFO - TEST-INFO | 3320: exit 0 22:19:11 INFO - Browser initialized. 22:19:11 INFO - Running cycle 1/1 for kraken test... 22:19:11 INFO - TEST-INFO | started process 3403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmR8lJu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:23 INFO - PROCESS | 3403 | RSS: Main: 173109248 22:19:23 INFO - PROCESS | 3403 | 22:19:25 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58515/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:26 INFO - PROCESS | 3403 | RSS: Main: 240320512 22:19:26 INFO - PROCESS | 3403 | 22:19:29 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58515/tests/kraken/driver.html?testName=audio-dft) 22:19:29 INFO - PROCESS | 3403 | RSS: Main: 216236032 22:19:29 INFO - PROCESS | 3403 | 22:19:33 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58515/tests/kraken/driver.html?testName=audio-fft) 22:19:33 INFO - PROCESS | 3403 | RSS: Main: 298647552 22:19:33 INFO - PROCESS | 3403 | 22:19:35 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58515/tests/kraken/driver.html?testName=audio-oscillator) 22:19:36 INFO - PROCESS | 3403 | RSS: Main: 207773696 22:19:36 INFO - PROCESS | 3403 | 22:19:38 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:39 INFO - PROCESS | 3403 | RSS: Main: 212766720 22:19:39 INFO - PROCESS | 3403 | 22:19:42 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58515/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:42 INFO - PROCESS | 3403 | RSS: Main: 248590336 22:19:42 INFO - PROCESS | 3403 | 22:19:46 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58515/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:46 INFO - PROCESS | 3403 | RSS: Main: 247562240 22:19:46 INFO - PROCESS | 3403 | 22:19:49 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58515/tests/kraken/driver.html?testName=json-parse-financial) 22:19:50 INFO - PROCESS | 3403 | RSS: Main: 247455744 22:19:50 INFO - PROCESS | 3403 | 22:19:51 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:52 INFO - PROCESS | 3403 | RSS: Main: 209403904 22:19:52 INFO - PROCESS | 3403 | 22:19:54 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58515/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:54 INFO - PROCESS | 3403 | RSS: Main: 216850432 22:19:54 INFO - PROCESS | 3403 | 22:19:56 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:57 INFO - PROCESS | 3403 | RSS: Main: 226127872 22:19:57 INFO - PROCESS | 3403 | 22:20:00 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:00 INFO - PROCESS | 3403 | RSS: Main: 235610112 22:20:00 INFO - PROCESS | 3403 | 22:20:03 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:04 INFO - PROCESS | 3403 | RSS: Main: 232042496 22:20:04 INFO - PROCESS | 3403 | 22:20:05 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:58515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58515/tests/kraken/driver.html?testName=ai-astar) 22:20:06 INFO - PROCESS | 3403 | RSS: Main: 282550272 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | __start_tp_report 22:20:06 INFO - PROCESS | 3403 | _x_x_mozilla_page_load 22:20:06 INFO - PROCESS | 3403 | _x_x_mozilla_page_load_details 22:20:06 INFO - PROCESS | 3403 | |i|pagename|runs| 22:20:06 INFO - PROCESS | 3403 | |0;ai-astar;108;111;111;109;113;110;110;110;111;110 22:20:06 INFO - PROCESS | 3403 | |1;audio-beat-detection;149;126;123;175;126;122;127;124;155;121 22:20:06 INFO - PROCESS | 3403 | |2;audio-dft;160;162;162;160;159;161;161;162;160;162 22:20:06 INFO - PROCESS | 3403 | |3;audio-fft;75;75;74;111;76;76;76;76;108;75 22:20:06 INFO - PROCESS | 3403 | |4;audio-oscillator;83;84;113;84;82;83;104;85;83;123 22:20:06 INFO - PROCESS | 3403 | |5;imaging-gaussian-blur;118;118;117;118;117;117;116;117;117;117 22:20:06 INFO - PROCESS | 3403 | |6;imaging-darkroom;147;148;147;146;146;146;147;180;147;147 22:20:06 INFO - PROCESS | 3403 | |7;imaging-desaturate;95;95;95;94;95;95;95;94;96;95 22:20:06 INFO - PROCESS | 3403 | |8;json-parse-financial;54;55;53;54;53;56;55;54;55;55 22:20:06 INFO - PROCESS | 3403 | |9;json-stringify-tinderbox;63;63;62;62;62;62;63;63;62;62 22:20:06 INFO - PROCESS | 3403 | |10;stanford-crypto-aes;81;80;81;82;81;80;81;82;86;79 22:20:06 INFO - PROCESS | 3403 | |11;stanford-crypto-ccm;133;140;130;128;128;131;138;138;167;140 22:20:06 INFO - PROCESS | 3403 | |12;stanford-crypto-pbkdf2;170;168;171;171;172;172;169;168;171;172 22:20:06 INFO - PROCESS | 3403 | |13;stanford-crypto-sha256-iterative;67;67;66;69;67;67;65;64;65;65 22:20:06 INFO - PROCESS | 3403 | __end_tp_report 22:20:06 INFO - PROCESS | 3403 | __start_cc_report 22:20:06 INFO - PROCESS | 3403 | _x_x_mozilla_cycle_collect,1597 22:20:06 INFO - PROCESS | 3403 | __end_cc_report 22:20:06 INFO - PROCESS | 3403 | __startTimestamp1475904006111__endTimestamp 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | ------- Summary: start ------- 22:20:06 INFO - PROCESS | 3403 | Number of tests: 14 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:1.34 (1.2%) stddev-sans-first:1.13 22:20:06 INFO - PROCESS | 3403 | Values: 108.0 111.0 111.0 109.0 113.0 110.0 110.0 110.0 111.0 110.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:126.50 stddev:18.41 (14.6%) stddev-sans-first:18.80 22:20:06 INFO - PROCESS | 3403 | Values: 149.0 126.0 123.0 175.0 126.0 122.0 127.0 124.0 155.0 121.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 22:20:06 INFO - PROCESS | 3403 | Values: 160.0 162.0 162.0 160.0 159.0 161.0 161.0 162.0 160.0 162.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.50 stddev:14.42 (19.1%) stddev-sans-first:15.06 22:20:06 INFO - PROCESS | 3403 | Values: 75.0 75.0 74.0 111.0 76.0 76.0 76.0 76.0 108.0 75.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.00 stddev:15.15 (18.2%) stddev-sans-first:15.68 22:20:06 INFO - PROCESS | 3403 | Values: 83.0 84.0 113.0 84.0 82.0 83.0 104.0 85.0 83.0 123.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 22:20:06 INFO - PROCESS | 3403 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:147.00 stddev:10.52 (7.2%) stddev-sans-first:11.10 22:20:06 INFO - PROCESS | 3403 | Values: 147.0 148.0 147.0 146.0 146.0 146.0 147.0 180.0 147.0 147.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:20:06 INFO - PROCESS | 3403 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 96.0 95.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 22:20:06 INFO - PROCESS | 3403 | Values: 54.0 55.0 53.0 54.0 53.0 56.0 55.0 54.0 55.0 55.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 22:20:06 INFO - PROCESS | 3403 | Values: 63.0 63.0 62.0 62.0 62.0 62.0 63.0 63.0 62.0 62.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:1.89 (2.3%) stddev-sans-first:2.00 22:20:06 INFO - PROCESS | 3403 | Values: 81.0 80.0 81.0 82.0 81.0 80.0 81.0 82.0 86.0 79.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:138.00 stddev:11.46 (8.3%) stddev-sans-first:12.05 22:20:06 INFO - PROCESS | 3403 | Values: 133.0 140.0 130.0 128.0 128.0 131.0 138.0 138.0 167.0 140.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:1.58 (0.9%) stddev-sans-first:1.67 22:20:06 INFO - PROCESS | 3403 | Values: 170.0 168.0 171.0 171.0 172.0 172.0 169.0 168.0 171.0 172.0 22:20:06 INFO - PROCESS | 3403 | 22:20:06 INFO - PROCESS | 3403 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.54 22:20:06 INFO - PROCESS | 3403 | Values: 67.0 67.0 66.0 69.0 67.0 67.0 65.0 64.0 65.0 65.0 22:20:06 INFO - PROCESS | 3403 | -------- Summary: end -------- 22:20:06 INFO - PROCESS | 3403 | 22:20:07 INFO - TEST-INFO | 3403: exit 0 22:20:07 INFO - TEST-OK | kraken | took 62021ms 22:20:07 INFO - SUITE-END | took 1179s 22:20:07 INFO - Completed test suite (00:19:39) 22:20:07 INFO - javascript benchmark 22:20:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.9999999999995, 3058.8011779234334, 3060.143159915224, 3090.196548897286, 3113.7508999280058, 5076.771545280462, 5180.533751962323, 5237.8690532736655, 5254.343207099113, 5275.393329767083, 5206.609504287175, 5226.05930932433, 5227.660202086861, 5233.424323324441, 5239.240310155025, 4672.322513235587, 4773.379460670108, 4873.439554451248, 4904.068227036852, 4937.6790508617005, 4794.712317260958, 4799.400074990626, 4801.399825021872, 4864.075825593126, 4867.0, 4814.1334559779225, 4904.117258893398, 4906.141425250585, 4947.876303092416, 4958.652894297401, 4853.39332583427, 4896.1186986342445, 4906.484819093979, 4940.876478088041, 4955.331030310898, 4677.368555245032, 4681.180793361183, 4747.192977193851, 4747.810087596492, 4876.049170411771, 5244.632875698702, 5261.316028916254, 5285.6300058995885, 5306.73466326686, 5355.678659280456, 5685.545156387479, 5689.743961521742, 5700.116481945305, 5723.856903577403, 5746.051901436258, 5578.274824272859, 5637.8590535236945, 5696.2594862668, 5717.48542631161, 5725.2843394575675, 5271.683698978035, 5311.5750739941095, 5350.411454739976, 5390.54180394663, 5406.91889621656, 5888.764449422061, 5891.1752354669525, 5899.292084949833, 5899.557533184942, 5900.468957793733, 5417.458254174551, 5461.044317244467, 5653.378128405872, 5655.123455864347, 5659.773609055592, 5501.477359650827, 5634.408387119375, 5686.402927692533, 5725.656460612293, 5797.8550536236935, 5678.801241956512, 5707.143928410772, 5710.200571919934, 5717.571182161355, 5785.71071446426, 5567.582431317667, 5670.858228544319, 5706.828795136153, 5717.199592057115, 5724.227229324071, 4384.0, 4394.692371533962, 4434.246178149722, 4439.64482841372, 4444.2222611042935, 3961.2275606256503, 3962.2075584883137, 3994.6205110514456, 3996.620321069494, 4001.0597509585223, 5444.156155795858, 5451.972740136274, 5462.6449280797415, 5464.726763661881, 5497.862553436116, 5587.106063029895, 5764.798232061858, 5770.278715160605, 5781.797637082682, 5786.334571524244, 5296.390915044819, 5355.812546560929, 5420.322459692538, 5427.6472029317965, 5504.697241651667, 4987.226979818134, 4989.700617962933, 4994.850154495371, 5004.774785134678, 5064.82273120439, 5689.971550142222, 5904.704764761745, 5908.734106965283, 5914.0537513998415, 5919.4080591940465, 5588.0, 5591.18927755465, 5646.322441307069, 5654.349749778664, 5752.827415177551, 5752.252207213036, 5796.275465566804, 5796.913046304225, 5797.043487824461, 5803.187553742395, 5536.667799932017, 5579.804706835242, 5580.051391263576, 5588.077967135378, 5595.244641973444, 5623.268975033219, 5661.094224923992, 5670.5180059695385, 5684.459976302244, 5729.627574207663, 5594.496495315441, 5602.971985140048, 5607.43925607436, 5608.635438696635, 5665.235193248858, 5507.807226747044, 5559.944400555943, 5563.972180139073, 5570.91643625354, 5594.636348637326, 5347.572194224531, 5407.242985982044, 5416.945830541802, 5430.212619170277, 5548.528375088163, 5566.582506312124, 5615.6630602164005, 5616.691081990366, 5676.063449530781, 5690.800821971211, 5432.483914028161, 5473.890522189614, 5480.177973304037, 5480.698561579152, 5563.638363506359], "value": 5250.638522807646, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5756321380479, 593.2643522032679, 615.5844804756788, 623.2334228898452, 637.3881074168797, 30984.53523197151, 31830.522542161856, 46547.76726116369, 46787.76606116973, 46968.295475567895, 44421.111577768424, 44838.775806120924, 44861.0, 44985.0, 45011.0, 8807.207351338378, 9008.0, 9015.413998090136, 9015.594298256594, 9017.23353514952, 8762.737117886474, 8847.159519845605, 8848.778780530505, 8855.247303979137, 8859.645614175426, 8855.380123391365, 8898.777530561756, 8904.59929303183, 8908.955455222715, 8908.955455222747, 8820.779480512974, 8849.911500884973, 8857.158569935846, 8857.379983401164, 8857.822843543125, 8725.781855453664, 8799.428037177628, 8817.206451419339, 8822.558872056372, 8826.338024648177, 42553.0, 42765.57234427647, 42876.0, 42876.57123428757, 42919.14161716748, 3554.3957527220437, 3556.8043757593323, 3741.363968125398, 4109.815058322382, 4120.1553681495525, 31024.37951240985, 31291.217719556964, 31964.0, 32014.19964500883, 32699.6730032699, 4239.342901850218, 4289.356596510517, 4312.0, 4325.156594464081, 4330.112326972963, 352687.0, 353211.0, 355934.0, 357089.0, 358154.0, 57133.42866571281, 57372.0, 57611.0, 57648.42351576514, 57733.711331443075, 36231.27537449236, 37043.96164728747, 37058.25883482315, 39272.41091383631, 39304.41043384351, 17531.211095500734, 17720.379786707403, 17740.379086731904, 17741.55646108832, 17761.911190443963, 13665.0, 13846.861531384759, 13859.861401385857, 13861.653458663412, 13862.722745545032, 18854.0, 19029.0, 19064.0, 19070.61858762817, 19091.713624295648, 7113.82215444618, 7135.714571417086, 7213.531120477152, 7227.205007449176, 7436.73971410998, 906.9365144439826, 981.293468702533, 988.7132731507783, 1033.540074666781, 1037.3205550364523, 30896.53655195174, 30988.69011309903, 31326.216844578612, 31345.686543134732, 31970.0, 1068.1081297116993, 1075.1506310015156, 1086.706589220906, 1103.089950790601, 1149.3161568866678, 16112.677746445006, 16839.662111009206, 16903.746443803353, 16973.49079527616, 17296.654066918843, 146488.26755866152, 147193.0, 147360.26319868545, 148293.0, 148605.0, 56750.7162464185, 57341.0, 57423.425765741806, 57452.42547574554, 57528.42471575314, 1212.5028738217288, 1270.1426537087614, 1314.1523717202351, 1314.9605511834661, 1338.1302153600238, 29351.559726604544, 32672.0, 32960.1759956003, 33102.33795324128, 33353.499697505045, 49976.500234997184, 53654.73172634268, 55050.0, 55306.72346638241, 60819.69590152021, 507472.0, 512346.0, 512682.0, 513833.0, 516777.0, 34096.0, 35337.63922493873, 41742.0, 43497.34753978756, 43745.56254437415, 46837.76581117073, 46994.53005469902, 47166.52833471759, 47173.0, 47260.0, 38644.420333694456, 39375.0, 39421.408678869266, 39950.40074398944, 41288.0, 39370.803145984086, 39708.0, 40005.79997099996, 40257.79871100626, 41577.58422415858, 40082.0, 40134.79932600435, 40195.79902100471, 40815.38776918408, 40846.79576602098, 33779.831100845324, 36048.639513604525, 36116.63883361133, 36649.0, 36986.0, 26605.600915985888, 27097.322566935985, 27147.0, 27352.863235683693, 27683.58474622842], "value": 19413.237672724827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.6544575671501, 403.650842021651, 409.6231467050314, 413.31596208275295, 428.6270944278476, 13556.0, 18186.454406367797, 18906.43280701578, 19901.0, 19990.400287991346, 14927.776083358758, 15417.460388886391, 17842.10789460525, 17992.370267040624, 18253.45239642813, 5405.702686352249, 5780.50865676418, 5804.622699524539, 5806.10005449154, 5806.129080637917, 5622.156676498517, 5774.913376299359, 5853.414658534155, 5865.413458654122, 5870.0314448116005, 5767.279090113736, 5781.190633311318, 5807.535397168216, 5812.215350927634, 5816.098504731774, 5556.416576259475, 5747.195392645033, 5755.2805899262385, 5766.250387449647, 5773.105168698838, 5651.519620832234, 5659.0, 5673.886522269573, 5713.200151978726, 5726.3414707308775, 13618.455261789517, 20023.599528009505, 22136.557268854533, 22229.55540889173, 22335.10659573615, 2054.7431571053617, 2184.7050648162613, 2366.810655147584, 2413.698287714036, 2741.424300896814, 9552.522373881347, 9835.114839664393, 10122.949385253027, 10292.228082893813, 10359.32664376813, 1875.6998880179242, 1920.898340455141, 1937.5156210947264, 1953.4042117154263, 1982.5043739065234, 81697.0, 81959.0, 82660.58669706613, 87881.0, 91007.08992910052, 10825.621103261348, 10875.238733288752, 11052.060574851228, 11155.832662510069, 11228.27016243958, 15655.138967356905, 15688.058716477048, 15738.449154279546, 15805.52583422499, 15808.209589520708, 7286.927130728731, 7595.5442673438665, 7738.845223095506, 7948.767940969159, 8193.71322003727, 7468.327850493373, 7490.400767938552, 7618.0, 7679.385649148055, 7728.574928378993, 4694.131585656664, 4721.5278472153195, 4828.565429111327, 4887.193613053806, 4909.631777616622, 1822.2670942708974, 1823.8075199881343, 1937.98062019378, 2041.9489512762002, 2101.3065688322818, 871.9171678690515, 914.7895983923735, 925.9490728009889, 949.2832911152174, 1021.3820638513592, 17119.0, 18115.54711132232, 18454.0, 18532.536686582673, 18887.0, 904.2404380320562, 966.0387914025589, 972.0473935543207, 979.7011911366959, 984.4044353166231, 8119.594020298961, 9954.800903981879, 10351.06840384369, 10555.736106597244, 10607.946960265304, 486149.0, 494900.0, 495147.0, 498669.0, 512618.0, 92842.53578732198, 94724.0, 95929.52035239918, 97485.51257243668, 98359.01640983642, 954.6610953111684, 976.1312431935582, 1029.361795686679, 1029.7837454134565, 1030.314840630987, 15926.362945482515, 16242.187890605659, 17276.740848887024, 17395.91302043482, 17408.541722418922, 43447.34828977631, 43790.12419751651, 44305.33541996937, 44727.0, 45595.54404455913, 59575.702121489114, 60692.10381059971, 60924.69537652283, 62012.0, 63452.365476346495, 8244.628991695508, 8319.542425166674, 8341.833163336578, 8348.666053357798, 8353.665853365797, 12493.812592810933, 12648.0, 12798.360081995677, 12891.548795792478, 12898.226106433269, 10691.679249622524, 11322.716932076764, 11354.0, 11613.6515904523, 11623.56092101039, 10918.508667110158, 11225.550977960791, 11248.0, 11281.266717663326, 11526.827097593376, 11334.773304534028, 11405.714857128638, 11418.0, 11465.254758440675, 11836.349000804694, 7242.13094428672, 7638.50349727266, 8501.277391421798, 8507.914920850711, 9006.279497640042, 10043.246756493147, 10583.782864970626, 10640.787184256425, 10820.268756998843, 11733.471993760131], "value": 9061.1062129083, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.7179035983158, 1530.2501774130676, 1629.8859079864408, 1735.0804073840868, 1801.0094448053567, 8035.357171426286, 8315.126911674277, 8584.141585841413, 9267.721968340944, 9307.069293070697, 8565.0, 8901.376903616734, 8928.821423571524, 9192.402493837913, 9207.401518901266, 2393.2700526339504, 2418.5404773093146, 2421.6730741349957, 2422.648715936197, 2426.7502236348296, 1989.661757501221, 2051.148773259103, 2412.8552286862846, 2413.372523143986, 2429.0405289910564, 2298.1726578431753, 2374.169040835702, 2374.798142157919, 2380.571816746926, 2389.940251493718, 2326.069572171128, 2352.270796053212, 2390.748971358, 2428.890699918508, 2429.5748244057218, 2334.4163959010248, 2354.9411264718347, 2362.5511152881068, 2364.9054037838464, 2379.5003049359484, 9118.680846170419, 9144.8628270576, 9203.723888283363, 9222.216111630452, 9234.953825230898, 5288.735563221862, 5415.431379705114, 5422.43064478232, 5432.320959880015, 5457.699826509541, 3378.45944648855, 3466.670666286724, 3497.877574284888, 3506.8421921013614, 3551.200979779555, 1122.360254654847, 1164.598213616301, 1176.7293522489874, 1191.023360844108, 1201.0571701214592, 12832.422540985584, 12928.741425171538, 12972.481100755958, 12974.026947978846, 12980.480780768758, 4765.404324459442, 4765.69023013503, 4784.0, 4830.903381932341, 4967.081089998362, 10673.092787113183, 10705.732356690989, 10708.73228169302, 10714.303570267908, 10719.624813131659, 5180.585553155738, 5203.635745497779, 5208.0, 5210.114280572312, 5212.139996900469, 4698.765061746967, 4753.215719406328, 4755.310479980383, 4762.476127625959, 4838.104950584153, 3977.3039718049226, 4002.8598999035476, 4089.8568550100604, 4137.482814648169, 4160.729552579072, 1239.975200495985, 1269.2638269803492, 1291.1478424239956, 1325.2114991579995, 1333.2667033131738, 808.3412019204329, 873.5457562067817, 885.8051228729669, 893.5666201892077, 913.2785099771239, 5475.534579560703, 5482.91775623366, 5533.723313834373, 5571.526420254324, 5764.221830052973, 856.7943693513512, 862.9784255393665, 884.2351366068305, 918.9218916392048, 934.7382732834817, 3649.50731651229, 3713.350163721338, 3768.9516329472913, 3822.1782316802023, 3861.131245469747, 10511.316764410289, 10729.678109656723, 11391.715207119889, 11395.746467888526, 11403.0, 10960.068394186583, 11020.614278500374, 11063.778724425467, 11065.612703555336, 11068.612598559012, 8084.474509156886, 8227.095019547845, 8231.259186673227, 8280.917190828015, 8433.873491897626, 5618.7190640467, 5627.803026894039, 5785.913211301918, 5787.7395517200985, 5791.594588378942, 9853.0, 9882.25883058759, 9990.450525221182, 10091.19270458347, 10302.536385862804, 10115.291929564859, 10215.693529194135, 10534.315269507457, 10723.410212438392, 10782.299150555189, 7617.085949686073, 7698.114716807639, 7763.68945242184, 7896.6446509906045, 7941.682332706858, 8453.239208471266, 8595.570221488775, 8598.699045533627, 8600.870986935326, 8609.053004169662, 7494.288042635941, 7637.427192960439, 7682.423818213544, 7725.343345815669, 8026.83946321082, 7661.885071723817, 7685.193054729173, 7776.377889768918, 7786.961065194638, 8041.155678653658, 6694.866102677822, 6792.660366981532, 6798.422134118655, 6808.489363297674, 6809.455243580403, 4635.65232607549, 4808.567228949411, 4817.156997525489, 4858.708477491362, 4883.047805678001, 4828.396450443694, 4841.491643377394, 4914.287428322802, 4937.777799998937, 5132.7433628317685], "value": 4647.049605466959, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.6810117242337, 335.2958786548249, 341.66687479707304, 342.14122552393485, 342.29316461507, 5287.048331300369, 5309.8938021239555, 5322.547583455401, 5333.626646134772, 5375.704336261514, 5262.0, 5270.9736451317785, 5276.868078298035, 5289.973550132254, 5304.840854774353, 4145.626893579577, 4156.064885400783, 4187.769672668002, 4191.706580539363, 4217.894552636178, 3854.383298672213, 3939.940900886489, 4097.569755175708, 4138.461999940018, 4141.254574176647, 4110.23960567296, 4123.484564429446, 4123.8350465981475, 4136.917261654765, 4136.958630413703, 4121.866486716147, 4127.2570937231285, 4129.607687269705, 4140.171965606891, 4144.378343248507, 3474.0, 3478.7564870459078, 3611.56661200655, 3618.2763447310645, 3659.9451008234896, 5091.134507133759, 5103.8468845934685, 5108.445777111444, 5122.154844450662, 5142.305788718512, 4728.432588089417, 4737.218358970766, 4737.620990320766, 4745.528886045303, 4750.334953106568, 5384.3538775346815, 5390.865228369322, 5427.755750991215, 5453.372862120827, 5471.398146203915, 4018.45750823638, 4023.5574086850424, 4040.8583450770843, 4057.1885622875543, 4066.8983275418054, 5635.408282130399, 5722.942770572325, 5728.283964504437, 5735.254416925773, 5736.627119237236, 4075.836966521306, 4100.487439070116, 4102.2000709861295, 4105.363668631367, 4118.691098167589, 4163.604457576525, 4187.14163596462, 4198.370244463294, 4209.284421648327, 4211.599898009684, 4756.167670657621, 4760.523947605212, 4761.738104404291, 4762.166620841408, 4789.233722604366, 5323.547498462674, 5444.156155795858, 5489.39616642169, 5502.394736578973, 5566.471185237396, 1431.3487363249697, 1445.7205373244753, 1447.3052934591456, 1448.2107251547932, 1448.7826825976188, 989.2086330935223, 1016.6848277034143, 1025.466757286207, 1031.3708637730979, 1037.3827572594446, 5144.9742751286, 5269.894602107936, 5281.973590132025, 5286.326003427581, 5297.496737809902, 5525.1214587040595, 5552.888942221133, 5680.8863822723315, 5685.630434021776, 5716.485516303553, 5374.044275648378, 5383.569314454834, 5383.650062745909, 5385.165299378603, 5416.350037995466, 2884.7259510346485, 2990.2524368907775, 2998.415309014721, 2998.625171853518, 3011.2471882029495, 5826.912596311059, 5829.8251052468495, 5830.970845145747, 5832.562557808182, 5846.070796637099, 5552.611317207757, 5803.854903627359, 5830.067189249785, 5838.32859221195, 5839.0, 5803.564732644984, 5845.444682755132, 5851.239338885917, 5856.038227193852, 5870.7945221917025, 5673.8297851064535, 5694.829155125353, 5696.601237913306, 5703.8859222816145, 5743.885122297447, 5408.323959505062, 5583.776648934159, 5614.2701448811395, 5654.943450565442, 5661.0, 5806.361300257053, 5837.6497410155525, 5842.824715258549, 5845.561582881216, 5848.795292164754, 4037.4145748866836, 4101.528324242631, 4110.2601531723385, 4117.238310912491, 4123.628873401408, 5486.61593688438, 5701.971490142523, 5708.857278568069, 5718.999175144416, 5770.6249093808765, 5559.861003474945, 5569.443055694398, 5576.665400076008, 5577.52591029767, 5590.99362114807, 5209.889994552213, 5547.918155959549, 5576.1356989666665, 5639.689817060101, 5648.774049038157, 5401.135818269058, 5427.375851777097, 5460.426655201147, 5466.125419932791, 5473.370562385377, 5219.556337711185, 5493.615446918678, 5536.557075433875, 5566.944330556643, 5567.498925096761, 5255.500727430888, 5295.735213239245, 5418.322709661293, 5442.428545002717, 5460.31746031746], "value": 4241.913588332435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.8527566573187, 724.8151721311065, 776.8990031295931, 824.5629816197418, 828.6312590897053, 15957.361705531779, 17096.23066961985, 17116.229769660364, 17126.229319680613, 17221.13894305286, 14216.573502794907, 14891.925540372311, 15220.619484512892, 15268.923655381735, 15418.229088545555, 816.6610856494548, 838.7609531283586, 842.3766412854475, 842.9199226073513, 843.0431460292551, 684.6576711644178, 697.8360085379932, 815.1725998111921, 841.7600983719641, 845.733593917917, 855.110684887716, 857.0529564830865, 862.1895418306802, 874.4316194473579, 874.5059041641452, 866.9913300867005, 867.6269204242174, 868.6351732272461, 869.4088020146298, 869.752120645613, 513.3659929986501, 524.0331588219728, 621.0373920423326, 635.5900444213503, 635.9173307470046, 14902.180380079091, 15180.0, 15240.46658366963, 15255.771163432557, 15342.769858452131, 13412.396442160029, 13498.392572334269, 13967.65080872976, 13999.16005039701, 14364.64088397788, 12946.223226606433, 12965.805512917314, 13092.607221783363, 13212.405441755049, 13654.590362289147, 4468.218061839165, 4482.820687172509, 4522.457305123374, 4526.366308716782, 4591.83928562502, 83469.0, 85524.57237713771, 85924.0, 86560.13439865583, 87731.56134219289, 11608.30350178992, 11618.128640352008, 11623.12826538013, 11625.302481851117, 11694.2983420995, 22012.559748804935, 22075.66886496704, 22134.114635414404, 22263.666045009337, 22279.0, 8298.377621678399, 8359.540225287668, 8384.958075209706, 8424.536650484282, 8558.700445484503, 4445.575634173224, 4525.0, 4544.477385100689, 4611.654125940568, 4772.6420518461255, 3365.848536815849, 3468.3063387322636, 3473.0, 3473.3227020730715, 3473.7047350974944, 663.6117871045396, 672.2168673495421, 673.1551902362504, 688.5421194905332, 688.5696439725172, 582.5223316880202, 599.2778701664483, 612.7732738886551, 619.3280290884351, 659.7789740436912, 8640.179182977607, 8780.341474389446, 8803.69187078462, 9081.490514502093, 9308.0, 566.6486778197544, 616.3435940723116, 670.7082419147687, 672.7376323233942, 685.1846302899534, 3946.585608511065, 4335.934960975588, 4338.349247612883, 4375.409319741858, 4425.336199570091, 72154.27845721581, 116920.0, 125435.3728231353, 125872.0, 130741.0, 64240.0, 78452.2154778445, 105799.4710026445, 106829.0, 114066.0, 91702.54148729348, 93702.53148734213, 94029.5298523503, 94390.0, 95106.0, 8257.710980115668, 8306.293965013041, 8320.340609258834, 8395.664173432995, 8709.520976346363, 52177.7391113042, 53881.46118538764, 54026.0, 55093.0, 57232.42767572271, 72088.0, 72843.0, 79870.0, 81367.59316203381, 84358.57820710857, 11055.72360690989, 11538.192326537062, 11541.249818761753, 11613.941930290295, 11629.825552616549, 12349.444275007467, 12380.62858114258, 12399.938000310302, 12465.065120115847, 12472.376381180724, 11633.59282425145, 11827.408629568316, 11849.644510664693, 11981.580644677395, 12597.181183223061, 12276.263424194576, 12971.805422918475, 13745.931270343584, 13947.30263486842, 14010.299485025911, 14001.5099471518, 14192.432302708188, 14272.571822845332, 14723.631909202355, 15104.622384440478, 11283.0, 11350.772984540428, 11553.364564949008, 11855.98109265691, 12952.611421657366, 11844.940775296069, 12568.74862502763, 12723.363831808558, 12761.87238127644, 12821.487140514648], "value": 7532.82363456627, "unit": "score"}], "name": "dromaeo_css", "value": 7181.337093947902, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 111.0, 109.0, 113.0, 110.0, 110.0, 110.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 123.0, 175.0, 126.0, 122.0, 127.0, 124.0, 155.0, 121.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 160.0, 159.0, 161.0, 161.0, 162.0, 160.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 111.0, 76.0, 76.0, 76.0, 76.0, 108.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 113.0, 84.0, 82.0, 83.0, 104.0, 85.0, 83.0, 123.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 146.0, 146.0, 147.0, 180.0, 147.0, 147.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 54.0, 53.0, 56.0, 55.0, 54.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 82.0, 81.0, 80.0, 81.0, 82.0, 86.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 140.0, 130.0, 128.0, 128.0, 131.0, 138.0, 138.0, 167.0, 140.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 171.0, 171.0, 172.0, 172.0, 169.0, 168.0, 171.0, 172.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 69.0, 67.0, 67.0, 65.0, 64.0, 65.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1514.8000000000002, "alertThreshold": 2.0}]} 22:20:07 INFO - Return code: 0 22:20:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:20:07 INFO - # TBPL SUCCESS # 22:20:07 INFO - Running post-action listener: _resource_record_post_action 22:20:07 INFO - [mozharness: 2016-10-08 05:20:07.929587Z] Finished run-tests step (success) 22:20:07 INFO - Running post-run listener: _resource_record_post_run 22:20:08 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399433728; Read time: 12; Write time: 323708 22:20:08 INFO - TinderboxPrint: CPU usage
13.0% 22:20:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:20:08 INFO - TinderboxPrint: I/O write bytes / time
399,433,728 / 323,708 22:20:08 INFO - TinderboxPrint: CPU idle
8,308.3 (87.0%) 22:20:08 INFO - TinderboxPrint: CPU user
1,191.4 (12.5%) 22:20:08 INFO - TinderboxPrint: Swap in / out
0 / 0 22:20:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110002176; Read time: 0; Write time: 92940 22:20:08 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289144832; Read time: 0; Write time: 230740 22:20:08 INFO - Running post-run listener: _upload_blobber_files 22:20:08 INFO - Blob upload gear active. 22:20:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:20:08 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 22:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:20:08 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:09 INFO - (blobuploader) - INFO - Done attempting. 22:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:10 INFO - (blobuploader) - INFO - Done attempting. 22:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:14 INFO - (blobuploader) - INFO - Done attempting. 22:20:14 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:14 INFO - Return code: 0 22:20:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:20:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/337eae1703857152fd16ea132337716d33935009e5519e3806e898896251a164bdfddfc9c46f9e1db65a57a1d2377c586ad36170029ebd4b1f18b9500000db06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/600377226d6c93b540e3db15eabec0a8e468a897fa04d51b666427f1a27a8a7cae61974afe3ee4d4481466cca8e995bd9f39d4ae39de0625bee5523f3e76a4e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5208f1d34a3d748519206b2f44ab4f14bd751ea376e7c54b5e91219a46071e13e33980f64cfdbc175baaaf69445a71b869327d657e5ca2eb035204bc3a8fa21a"} 22:20:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:20:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:20:14 INFO - Contents: 22:20:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/337eae1703857152fd16ea132337716d33935009e5519e3806e898896251a164bdfddfc9c46f9e1db65a57a1d2377c586ad36170029ebd4b1f18b9500000db06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/600377226d6c93b540e3db15eabec0a8e468a897fa04d51b666427f1a27a8a7cae61974afe3ee4d4481466cca8e995bd9f39d4ae39de0625bee5523f3e76a4e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5208f1d34a3d748519206b2f44ab4f14bd751ea376e7c54b5e91219a46071e13e33980f64cfdbc175baaaf69445a71b869327d657e5ca2eb035204bc3a8fa21a"} 22:20:14 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:14 INFO - Copying logs to upload dir... 22:20:14 INFO - mkdir: /builds/slave/test/build/upload/logs 22:20:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.755729 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-07 22:20:14.404687) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 22:20:14.409368) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/337eae1703857152fd16ea132337716d33935009e5519e3806e898896251a164bdfddfc9c46f9e1db65a57a1d2377c586ad36170029ebd4b1f18b9500000db06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/600377226d6c93b540e3db15eabec0a8e468a897fa04d51b666427f1a27a8a7cae61974afe3ee4d4481466cca8e995bd9f39d4ae39de0625bee5523f3e76a4e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5208f1d34a3d748519206b2f44ab4f14bd751ea376e7c54b5e91219a46071e13e33980f64cfdbc175baaaf69445a71b869327d657e5ca2eb035204bc3a8fa21a"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475890207/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/337eae1703857152fd16ea132337716d33935009e5519e3806e898896251a164bdfddfc9c46f9e1db65a57a1d2377c586ad36170029ebd4b1f18b9500000db06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/600377226d6c93b540e3db15eabec0a8e468a897fa04d51b666427f1a27a8a7cae61974afe3ee4d4481466cca8e995bd9f39d4ae39de0625bee5523f3e76a4e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5208f1d34a3d748519206b2f44ab4f14bd751ea376e7c54b5e91219a46071e13e33980f64cfdbc175baaaf69445a71b869327d657e5ca2eb035204bc3a8fa21a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 22:20:14.442904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:20:14.443256) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475902774.84042-1984845232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:20:14.527837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 22:20:14.528470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 22:20:14.529008) ========= ========= Total master_lag: 0.19 =========