builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1475896010.22 results: success (0) buildid: 20161007192202 builduid: 0a93ed32a2f142b9b475c334c9cbbda2 revision: c01ac374bce4f4f0b0a7c2f98b7febfe59b1fe97 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:50.221612) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:50.222663) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:50.223433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:50.239868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:50.240538) ========= 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=eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 20:06:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.7M=0s 2016-10-07 20:06:50 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:50.408802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:50.409183) ========= 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=eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018527 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:50.459705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 20:06:50.460066) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c01ac374bce4f4f0b0a7c2f98b7febfe59b1fe97 --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 c01ac374bce4f4f0b0a7c2f98b7febfe59b1fe97 --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=eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 20:06:50,889 truncating revision to first 12 chars 2016-10-07 20:06:50,889 Setting DEBUG logging. 2016-10-07 20:06:50,889 attempt 1/10 2016-10-07 20:06:50,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c01ac374bce4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 20:06:52,240 unpacking tar archive at: autoland-c01ac374bce4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.695411 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 20:06:52.173693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:52.174555) ========= script_repo_revision: c01ac374bce4f4f0b0a7c2f98b7febfe59b1fe97 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:52.175552) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:52.176253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 20:06:52.188585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-07 20:06:52.189333) ========= /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=eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:52 INFO - MultiFileLogger online at 20161007 20:06:52 in /builds/slave/test 20:06:52 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 20:06:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:52 INFO - {'append_to_log': False, 20:06:52 INFO - 'base_work_dir': '/builds/slave/test', 20:06:52 INFO - 'blob_upload_branch': 'Autoland', 20:06:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:52 INFO - 'branch': 'Autoland', 20:06:52 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:52 INFO - 'config_files': ('talos/linux_config.py',), 20:06:52 INFO - 'default_actions': ('clobber', 20:06:52 INFO - 'read-buildbot-config', 20:06:52 INFO - 'download-and-extract', 20:06:52 INFO - 'populate-webroot', 20:06:52 INFO - 'create-virtualenv', 20:06:52 INFO - 'install', 20:06:52 INFO - 'run-tests'), 20:06:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:52 INFO - 'download_minidump_stackwalk': True, 20:06:52 INFO - 'download_symbols': 'ondemand', 20:06:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:52 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:52 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:52 INFO - 'installer_path': 'installer.exe', 20:06:52 INFO - 'log_level': 'info', 20:06:52 INFO - 'log_name': 'talos', 20:06:52 INFO - 'log_to_console': True, 20:06:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:52 INFO - 'opt_config_files': (), 20:06:52 INFO - 'pip_index': False, 20:06:52 INFO - 'sps_profile': False, 20:06:52 INFO - 'sps_profile_interval': 0, 20:06:52 INFO - 'suite': 'dromaeojs', 20:06:52 INFO - 'system_bits': '32', 20:06:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:52 INFO - 'title': 'talos-linux64-ix-010', 20:06:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:52 INFO - 'use_talos_json': True, 20:06:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:52 INFO - 'work_dir': 'build'} 20:06:52 INFO - [mozharness: 2016-10-08 03:06:52.729103Z] Running clobber step. 20:06:52 INFO - Running pre-action listener: _resource_record_pre_action 20:06:52 INFO - Running main action method: clobber 20:06:52 INFO - rmtree: /builds/slave/test/build 20:06:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:53 INFO - Running post-action listener: _resource_record_post_action 20:06:53 INFO - [mozharness: 2016-10-08 03:06:53.199335Z] Finished clobber step (success) 20:06:53 INFO - [mozharness: 2016-10-08 03:06:53.199437Z] Running read-buildbot-config step. 20:06:53 INFO - Running pre-action listener: _resource_record_pre_action 20:06:53 INFO - Running main action method: read_buildbot_config 20:06:53 INFO - Using buildbot properties: 20:06:53 INFO - { 20:06:53 INFO - "project": "", 20:06:53 INFO - "product": "firefox", 20:06:53 INFO - "script_repo_revision": "production", 20:06:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 20:06:53 INFO - "repository": "", 20:06:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 20:06:53 INFO - "buildid": "20161007192202", 20:06:53 INFO - "stage_platform": "linux64-pgo", 20:06:53 INFO - "basedir": "/builds/slave/test", 20:06:53 INFO - "buildnumber": 333, 20:06:53 INFO - "platform": "ubuntu64_hw", 20:06:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:06:53 INFO - "slavebuilddir": "test", 20:06:53 INFO - "branch": "autoland", 20:06:53 INFO - "revision": "c01ac374bce4f4f0b0a7c2f98b7febfe59b1fe97", 20:06:53 INFO - "slavename": "talos-linux64-ix-010", 20:06:53 INFO - "builduid": "0a93ed32a2f142b9b475c334c9cbbda2", 20:06:53 INFO - "repo_path": "integration/autoland" 20:06:53 INFO - } 20:06:53 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:06:53 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 20:06:53 INFO - Running post-action listener: _resource_record_post_action 20:06:53 INFO - [mozharness: 2016-10-08 03:06:53.201820Z] Finished read-buildbot-config step (success) 20:06:53 INFO - [mozharness: 2016-10-08 03:06:53.201910Z] Running download-and-extract step. 20:06:53 INFO - Running pre-action listener: _resource_record_pre_action 20:06:53 INFO - Running main action method: download_and_extract 20:06:53 INFO - mkdir: /builds/slave/test/build/tests 20:06: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')]} 20:06:53 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:06:53 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:06:53 INFO - Downloaded 1361 bytes. 20:06:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:06:53 INFO - Using the following test package requirements: 20:06:53 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:53 INFO - u'jsshell-linux-x86_64.zip'], 20:06:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:53 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:06:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:06:53 INFO - Http code: 200 20:06:53 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 20:06:53 INFO - x-amz-cf-id: QzCDvRitn3gCXtKwbqUSapYsGMLmHFXlDVq3DRSv0YlOyughxJwr_g== 20:06:53 INFO - x-amz-replication-status: COMPLETED 20:06:53 INFO - x-amz-version-id: gNa9wSSLY2gFRTSSn5qKF6KtSBJ5PVEv 20:06:53 INFO - Expected file size: 22022239 20:06:53 INFO - Obtained file size: 22022239 20:06:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:06:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:06:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:57 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:06:57 INFO - Http code: 200 20:06:57 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 20:06:57 INFO - x-amz-cf-id: TIcTqYXoQG5PwF87qeLziytr64EOr6j2tMs9_4W60_GuewbzrkGiww== 20:06:57 INFO - x-amz-replication-status: COMPLETED 20:06:57 INFO - x-amz-version-id: gNa9wSSLY2gFRTSSn5qKF6KtSBJ5PVEv 20:06:57 INFO - Expected file size: 22022239 20:06:57 INFO - Obtained file size: 22022239 20:07:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:07:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:07:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:07:02 INFO - Http code: 200 20:07:02 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 20:07:02 INFO - x-amz-cf-id: 9SMd5ObRurcb07t4SSzzlDmHi89jmFYdjn3yCMWARCdQ1BJjwAu7WQ== 20:07:02 INFO - x-amz-replication-status: COMPLETED 20:07:02 INFO - x-amz-version-id: OJADGwNM35OvlamR92AfCgxwDS2BPmta 20:07:02 INFO - Expected file size: 14409006 20:07:02 INFO - Obtained file size: 14409006 20:07: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')]} 20:07:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:07:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:07:03 INFO - Downloaded 59711871 bytes. 20:07:03 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:07:03 INFO - mkdir: /builds/slave/test/properties 20:07:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:07:03 INFO - Writing to file /builds/slave/test/properties/build_url 20:07:03 INFO - Contents: 20:07:03 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:07:03 INFO - Running post-action listener: _resource_record_post_action 20:07:03 INFO - Running post-action listener: set_extra_try_arguments 20:07:03 INFO - [mozharness: 2016-10-08 03:07:03.932965Z] Finished download-and-extract step (success) 20:07:03 INFO - [mozharness: 2016-10-08 03:07:03.933196Z] Running populate-webroot step. 20:07:03 INFO - Running pre-action listener: _resource_record_pre_action 20:07:03 INFO - Running main action method: populate_webroot 20:07:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:07:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:07:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:07:03 INFO - '--tppagecycles', 20:07:03 INFO - '7'], 20:07:03 INFO - 'tests': ['tsvgm']}}, 20:07:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:07:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:07:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:07:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:07:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:03 INFO - 'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:07:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:07:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:03 INFO - 'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['damp', 'tps']}, 20:07:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:03 INFO - 'tests': ['damp', 'tps']}, 20:07:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['dromaeo_dom']}, 20:07:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:07:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['basic_compositor_video']}, 20:07:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:07:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['a11yr', 20:07:03 INFO - 'ts_paint', 20:07:03 INFO - 'tpaint', 20:07:03 INFO - 'sessionrestore', 20:07:03 INFO - 'sessionrestore_no_auto_restore', 20:07:03 INFO - 'tabpaint']}, 20:07:03 INFO - 'other-e10s': {'tests': ['a11yr', 20:07:03 INFO - 'ts_paint', 20:07:03 INFO - 'tpaint', 20:07:03 INFO - 'sessionrestore', 20:07:03 INFO - 'sessionrestore_no_auto_restore', 20:07:03 INFO - 'tabpaint']}, 20:07:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:07:03 INFO - 'ts_paint', 20:07:03 INFO - 'tpaint', 20:07:03 INFO - 'sessionrestore', 20:07:03 INFO - 'sessionrestore_no_auto_restore', 20:07:03 INFO - 'tabpaint']}, 20:07:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:07:03 INFO - 'ts_paint', 20:07:03 INFO - 'tpaint', 20:07:03 INFO - 'sessionrestore', 20:07:03 INFO - 'sessionrestore_no_auto_restore', 20:07:03 INFO - 'tabpaint']}, 20:07:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['a11yr', 20:07:03 INFO - 'ts_paint', 20:07:03 INFO - 'tpaint', 20:07:03 INFO - 'sessionrestore', 20:07:03 INFO - 'sessionrestore_no_auto_restore', 20:07:03 INFO - 'tabpaint']}, 20:07:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['a11yr', 20:07:03 INFO - 'ts_paint', 20:07:03 INFO - 'tpaint', 20:07:03 INFO - 'sessionrestore', 20:07:03 INFO - 'sessionrestore_no_auto_restore', 20:07:03 INFO - 'tabpaint']}, 20:07:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['tsvgx', 20:07:03 INFO - 'tsvgr_opacity', 20:07:03 INFO - 'tart', 20:07:03 INFO - 'tscrollx', 20:07:03 INFO - 'cart']}, 20:07:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:07:03 INFO - 'tsvgr_opacity', 20:07:03 INFO - 'tart', 20:07:03 INFO - 'tscrollx', 20:07:03 INFO - 'cart']}, 20:07:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:03 INFO - 'talos_options': ['--disable-e10s'], 20:07:03 INFO - 'tests': ['tp5o']}, 20:07:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:03 INFO - 'tests': ['tp5o']}, 20:07:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:03 INFO - 'talos_options': ['--disable-e10s', 20:07:03 INFO - '--xperf_path', 20:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:07:03 INFO - 'tests': ['tp5n']}, 20:07:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:03 INFO - 'talos_options': ['--xperf_path', 20:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:07:03 INFO - 'tests': ['tp5n']}}, 20:07:03 INFO - 'talos.zip': {'path': '', 20:07:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:07:03 INFO - Running post-action listener: _resource_record_post_action 20:07:03 INFO - [mozharness: 2016-10-08 03:07:03.953711Z] Finished populate-webroot step (success) 20:07:03 INFO - [mozharness: 2016-10-08 03:07:03.953800Z] Running create-virtualenv step. 20:07:03 INFO - Running pre-action listener: _resource_record_pre_action 20:07:03 INFO - Running main action method: create_virtualenv 20:07:03 INFO - Creating virtualenv /builds/slave/test/build/venv 20:07:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:07:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:07:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:07:04 INFO - Using real prefix '/usr' 20:07:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:07:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:07:06 INFO - Installing pip.................done. 20:07:06 INFO - Return code: 0 20:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:07:06 INFO - Reading from file tmpfile_stdout 20:07:06 INFO - Output received: 20:07:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:07:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:07:06 INFO - Using env: {'DISPLAY': ':0', 20:07:06 INFO - 'HOME': '/home/cltbld', 20:07:06 INFO - 'LANG': 'en_US.UTF-8', 20:07:06 INFO - 'LANGUAGE': 'en_US:en', 20:07:06 INFO - 'LOGNAME': 'cltbld', 20:07:06 INFO - 'MAIL': '/var/mail/cltbld', 20:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:06 INFO - 'MOZ_NO_REMOTE': '1', 20:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:06 INFO - 'NO_EM_RESTART': '1', 20:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:06 INFO - 'PWD': '/builds/slave/test', 20:07:06 INFO - 'SHELL': '/bin/bash', 20:07:06 INFO - 'SHLVL': '1', 20:07:06 INFO - 'TERM': 'linux', 20:07:06 INFO - 'TMOUT': '86400', 20:07:06 INFO - 'USER': 'cltbld', 20:07:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:06 INFO - '_': '/tools/buildbot/bin/python'} 20:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:07:06 INFO - Cleaning up... 20:07:06 INFO - Return code: 0 20:07:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:07:06 INFO - Using env: {'DISPLAY': ':0', 20:07:06 INFO - 'HOME': '/home/cltbld', 20:07:06 INFO - 'LANG': 'en_US.UTF-8', 20:07:06 INFO - 'LANGUAGE': 'en_US:en', 20:07:06 INFO - 'LOGNAME': 'cltbld', 20:07:06 INFO - 'MAIL': '/var/mail/cltbld', 20:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:06 INFO - 'MOZ_NO_REMOTE': '1', 20:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:06 INFO - 'NO_EM_RESTART': '1', 20:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:06 INFO - 'PWD': '/builds/slave/test', 20:07:06 INFO - 'SHELL': '/bin/bash', 20:07:06 INFO - 'SHLVL': '1', 20:07:06 INFO - 'TERM': 'linux', 20:07:06 INFO - 'TMOUT': '86400', 20:07:06 INFO - 'USER': 'cltbld', 20:07:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:06 INFO - '_': '/tools/buildbot/bin/python'} 20:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:07 INFO - Downloading/unpacking psutil>=3.1.1 20:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:07:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:09 INFO - Installing collected packages: psutil 20:07:09 INFO - Running setup.py install for psutil 20:07:09 INFO - building 'psutil._psutil_linux' extension 20:07:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:07:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:07:09 INFO - building 'psutil._psutil_posix' extension 20:07:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:07:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:07:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:09 INFO - Successfully installed psutil 20:07:09 INFO - Cleaning up... 20:07:09 INFO - Return code: 0 20:07:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:07: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')]} 20:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07: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')]} 20:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:07:09 INFO - Using env: {'DISPLAY': ':0', 20:07:09 INFO - 'HOME': '/home/cltbld', 20:07:09 INFO - 'LANG': 'en_US.UTF-8', 20:07:09 INFO - 'LANGUAGE': 'en_US:en', 20:07:09 INFO - 'LOGNAME': 'cltbld', 20:07:09 INFO - 'MAIL': '/var/mail/cltbld', 20:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:09 INFO - 'MOZ_NO_REMOTE': '1', 20:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:09 INFO - 'NO_EM_RESTART': '1', 20:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:09 INFO - 'PWD': '/builds/slave/test', 20:07:09 INFO - 'SHELL': '/bin/bash', 20:07:09 INFO - 'SHLVL': '1', 20:07:09 INFO - 'TERM': 'linux', 20:07:09 INFO - 'TMOUT': '86400', 20:07:09 INFO - 'USER': 'cltbld', 20:07:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:09 INFO - '_': '/tools/buildbot/bin/python'} 20:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:07:11 INFO - Installing collected packages: mozsystemmonitor 20:07:11 INFO - Running setup.py install for mozsystemmonitor 20:07:12 INFO - Successfully installed mozsystemmonitor 20:07:12 INFO - Cleaning up... 20:07:12 INFO - Return code: 0 20:07:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:07:12 INFO - Using env: {'DISPLAY': ':0', 20:07:12 INFO - 'HOME': '/home/cltbld', 20:07:12 INFO - 'LANG': 'en_US.UTF-8', 20:07:12 INFO - 'LANGUAGE': 'en_US:en', 20:07:12 INFO - 'LOGNAME': 'cltbld', 20:07:12 INFO - 'MAIL': '/var/mail/cltbld', 20:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:12 INFO - 'MOZ_NO_REMOTE': '1', 20:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:12 INFO - 'NO_EM_RESTART': '1', 20:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:12 INFO - 'PWD': '/builds/slave/test', 20:07:12 INFO - 'SHELL': '/bin/bash', 20:07:12 INFO - 'SHLVL': '1', 20:07:12 INFO - 'TERM': 'linux', 20:07:12 INFO - 'TMOUT': '86400', 20:07:12 INFO - 'USER': 'cltbld', 20:07:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:12 INFO - '_': '/tools/buildbot/bin/python'} 20:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:12 INFO - Downloading/unpacking jsonschema==2.5.1 20:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:07:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:14 INFO - Downloading functools32-3.2.3-2.tar.gz 20:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:07:14 INFO - warning: no files found matching '*.txt' 20:07:14 INFO - no previously-included directories found matching 'build' 20:07:14 INFO - no previously-included directories found matching 'dist' 20:07:14 INFO - no previously-included directories found matching '.git*' 20:07:14 INFO - Installing collected packages: jsonschema, functools32 20:07:14 INFO - Running setup.py install for functools32 20:07:14 INFO - warning: no files found matching '*.txt' 20:07:14 INFO - no previously-included directories found matching 'build' 20:07:14 INFO - no previously-included directories found matching 'dist' 20:07:14 INFO - no previously-included directories found matching '.git*' 20:07:14 INFO - Successfully installed jsonschema functools32 20:07:14 INFO - Cleaning up... 20:07:14 INFO - Return code: 0 20:07:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:14 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 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:07:14 INFO - Using env: {'DISPLAY': ':0', 20:07:14 INFO - 'HOME': '/home/cltbld', 20:07:14 INFO - 'LANG': 'en_US.UTF-8', 20:07:14 INFO - 'LANGUAGE': 'en_US:en', 20:07:14 INFO - 'LOGNAME': 'cltbld', 20:07:14 INFO - 'MAIL': '/var/mail/cltbld', 20:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:14 INFO - 'MOZ_NO_REMOTE': '1', 20:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:14 INFO - 'NO_EM_RESTART': '1', 20:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:14 INFO - 'PWD': '/builds/slave/test', 20:07:14 INFO - 'SHELL': '/bin/bash', 20:07:14 INFO - 'SHLVL': '1', 20:07:14 INFO - 'TERM': 'linux', 20:07:14 INFO - 'TMOUT': '86400', 20:07:14 INFO - 'USER': 'cltbld', 20:07:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:14 INFO - '_': '/tools/buildbot/bin/python'} 20:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:07:14 INFO - Cleaning up... 20:07:14 INFO - Return code: 0 20:07:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:14 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 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:07:14 INFO - Using env: {'DISPLAY': ':0', 20:07:14 INFO - 'HOME': '/home/cltbld', 20:07:14 INFO - 'LANG': 'en_US.UTF-8', 20:07:14 INFO - 'LANGUAGE': 'en_US:en', 20:07:14 INFO - 'LOGNAME': 'cltbld', 20:07:14 INFO - 'MAIL': '/var/mail/cltbld', 20:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:14 INFO - 'MOZ_NO_REMOTE': '1', 20:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:14 INFO - 'NO_EM_RESTART': '1', 20:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:14 INFO - 'PWD': '/builds/slave/test', 20:07:14 INFO - 'SHELL': '/bin/bash', 20:07:14 INFO - 'SHLVL': '1', 20:07:14 INFO - 'TERM': 'linux', 20:07:14 INFO - 'TMOUT': '86400', 20:07:14 INFO - 'USER': 'cltbld', 20:07:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:14 INFO - '_': '/tools/buildbot/bin/python'} 20:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:15 INFO - Downloading/unpacking blobuploader==1.2.4 20:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:07:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:07:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:17 INFO - Downloading docopt-0.6.1.tar.gz 20:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:07:17 INFO - Installing collected packages: blobuploader, requests, docopt 20:07:17 INFO - Running setup.py install for blobuploader 20:07:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:07:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:07:17 INFO - Running setup.py install for requests 20:07:18 INFO - Running setup.py install for docopt 20:07:18 INFO - Successfully installed blobuploader requests docopt 20:07:18 INFO - Cleaning up... 20:07:18 INFO - Return code: 0 20:07:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:07:18 INFO - Using env: {'DISPLAY': ':0', 20:07:18 INFO - 'HOME': '/home/cltbld', 20:07:18 INFO - 'LANG': 'en_US.UTF-8', 20:07:18 INFO - 'LANGUAGE': 'en_US:en', 20:07:18 INFO - 'LOGNAME': 'cltbld', 20:07:18 INFO - 'MAIL': '/var/mail/cltbld', 20:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:18 INFO - 'MOZ_NO_REMOTE': '1', 20:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:18 INFO - 'NO_EM_RESTART': '1', 20:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:18 INFO - 'PWD': '/builds/slave/test', 20:07:18 INFO - 'SHELL': '/bin/bash', 20:07:18 INFO - 'SHLVL': '1', 20:07:18 INFO - 'TERM': 'linux', 20:07:18 INFO - 'TMOUT': '86400', 20:07:18 INFO - 'USER': 'cltbld', 20:07:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:18 INFO - '_': '/tools/buildbot/bin/python'} 20:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:18 INFO - Running setup.py (path:/tmp/pip-gJ35qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:18 INFO - Running setup.py (path:/tmp/pip-NWl3ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:18 INFO - Running setup.py (path:/tmp/pip-5FGnIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:18 INFO - Running setup.py (path:/tmp/pip-FVFbCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:18 INFO - Running setup.py (path:/tmp/pip-3f9afQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:18 INFO - Running setup.py (path:/tmp/pip-NxQLoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:19 INFO - Running setup.py (path:/tmp/pip-_MnHG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:19 INFO - Running setup.py (path:/tmp/pip-k5B31y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:19 INFO - Running setup.py (path:/tmp/pip-p33boQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:19 INFO - Running setup.py (path:/tmp/pip-40OBo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:19 INFO - Running setup.py (path:/tmp/pip-Luxdoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:19 INFO - Running setup.py (path:/tmp/pip-quaIkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:19 INFO - Running setup.py (path:/tmp/pip-WRYrGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:19 INFO - Running setup.py (path:/tmp/pip-qif2RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:19 INFO - Running setup.py (path:/tmp/pip-pelfjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:19 INFO - Running setup.py (path:/tmp/pip-UI5C03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:19 INFO - Running setup.py (path:/tmp/pip-ktrqUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:07:19 INFO - Running setup.py install for manifestparser 20:07:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:07:19 INFO - Running setup.py install for mozcrash 20:07:20 INFO - Running setup.py install for mozdebug 20:07:20 INFO - Running setup.py install for mozdevice 20:07:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:07:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:07:20 INFO - Running setup.py install for mozfile 20:07:20 INFO - Running setup.py install for mozhttpd 20:07:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:07:20 INFO - Running setup.py install for mozinfo 20:07:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:07:20 INFO - Running setup.py install for mozInstall 20:07:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:07:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:07:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:07:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:07:20 INFO - Running setup.py install for mozleak 20:07:20 INFO - Running setup.py install for mozlog 20:07:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:07:20 INFO - Running setup.py install for moznetwork 20:07:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:07:21 INFO - Running setup.py install for mozprocess 20:07:21 INFO - Running setup.py install for mozprofile 20:07:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:07:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:07:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:07:21 INFO - Running setup.py install for mozrunner 20:07:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:07:21 INFO - Running setup.py install for mozscreenshot 20:07:21 INFO - Running setup.py install for moztest 20:07:21 INFO - Running setup.py install for mozversion 20:07:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:07:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:07:21 INFO - Cleaning up... 20:07:21 INFO - Return code: 0 20:07:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:21 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 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:07:21 INFO - Using env: {'DISPLAY': ':0', 20:07:21 INFO - 'HOME': '/home/cltbld', 20:07:21 INFO - 'LANG': 'en_US.UTF-8', 20:07:21 INFO - 'LANGUAGE': 'en_US:en', 20:07:21 INFO - 'LOGNAME': 'cltbld', 20:07:21 INFO - 'MAIL': '/var/mail/cltbld', 20:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:21 INFO - 'MOZ_NO_REMOTE': '1', 20:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:21 INFO - 'NO_EM_RESTART': '1', 20:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:21 INFO - 'PWD': '/builds/slave/test', 20:07:21 INFO - 'SHELL': '/bin/bash', 20:07:21 INFO - 'SHLVL': '1', 20:07:21 INFO - 'TERM': 'linux', 20:07:21 INFO - 'TMOUT': '86400', 20:07:21 INFO - 'USER': 'cltbld', 20:07:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:21 INFO - '_': '/tools/buildbot/bin/python'} 20:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:21 INFO - Running setup.py (path:/tmp/pip-wsUlYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:21 INFO - Running setup.py (path:/tmp/pip-bNeSCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:22 INFO - Running setup.py (path:/tmp/pip-AscoK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:22 INFO - Running setup.py (path:/tmp/pip-2gzW6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:22 INFO - Running setup.py (path:/tmp/pip-Lk6jKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:22 INFO - Running setup.py (path:/tmp/pip-4xRpb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:22 INFO - Running setup.py (path:/tmp/pip-fq_n7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:22 INFO - Running setup.py (path:/tmp/pip-kEdefS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:22 INFO - Running setup.py (path:/tmp/pip-Llu77N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:22 INFO - Running setup.py (path:/tmp/pip-iFn1p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:22 INFO - Running setup.py (path:/tmp/pip-pw7cBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:22 INFO - Running setup.py (path:/tmp/pip-3buVHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:22 INFO - Running setup.py (path:/tmp/pip-66CKnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:22 INFO - Running setup.py (path:/tmp/pip-R3Dnte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:22 INFO - Running setup.py (path:/tmp/pip-QqUi_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:23 INFO - Running setup.py (path:/tmp/pip-H1BVJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:23 INFO - Running setup.py (path:/tmp/pip-UgfcD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:07:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:25 INFO - Downloading blessings-1.6.tar.gz 20:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:07:25 INFO - Installing collected packages: blessings 20:07:25 INFO - Running setup.py install for blessings 20:07:25 INFO - Successfully installed blessings 20:07:25 INFO - Cleaning up... 20:07:25 INFO - Return code: 0 20:07:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:07:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:25 INFO - Reading from file tmpfile_stdout 20:07:25 INFO - Current package versions: 20:07:25 INFO - argparse == 1.2.1 20:07:25 INFO - blessings == 1.6 20:07:25 INFO - blobuploader == 1.2.4 20:07:25 INFO - docopt == 0.6.1 20:07:25 INFO - functools32 == 3.2.3-2 20:07:25 INFO - jsonschema == 2.5.1 20:07:25 INFO - manifestparser == 1.1 20:07:25 INFO - mozInstall == 1.12 20:07:25 INFO - mozcrash == 0.17 20:07:25 INFO - mozdebug == 0.1 20:07:25 INFO - mozdevice == 0.48 20:07:25 INFO - mozfile == 1.2 20:07:25 INFO - mozhttpd == 0.7 20:07:25 INFO - mozinfo == 0.9 20:07:25 INFO - mozleak == 0.1 20:07:25 INFO - mozlog == 3.4 20:07:25 INFO - moznetwork == 0.27 20:07:25 INFO - mozprocess == 0.23 20:07:25 INFO - mozprofile == 0.28 20:07:25 INFO - mozrunner == 6.12 20:07:25 INFO - mozscreenshot == 0.1 20:07:25 INFO - mozsystemmonitor == 0.3 20:07:25 INFO - moztest == 0.7 20:07:25 INFO - mozversion == 1.4 20:07:25 INFO - psutil == 3.1.1 20:07:25 INFO - requests == 1.2.3 20:07:25 INFO - wsgiref == 0.1.2 20:07:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:25 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 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:07:25 INFO - Using env: {'DISPLAY': ':0', 20:07:25 INFO - 'HOME': '/home/cltbld', 20:07:25 INFO - 'LANG': 'en_US.UTF-8', 20:07:25 INFO - 'LANGUAGE': 'en_US:en', 20:07:25 INFO - 'LOGNAME': 'cltbld', 20:07:25 INFO - 'MAIL': '/var/mail/cltbld', 20:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:25 INFO - 'MOZ_NO_REMOTE': '1', 20:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:25 INFO - 'NO_EM_RESTART': '1', 20:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:25 INFO - 'PWD': '/builds/slave/test', 20:07:25 INFO - 'SHELL': '/bin/bash', 20:07:25 INFO - 'SHLVL': '1', 20:07:25 INFO - 'TERM': 'linux', 20:07:25 INFO - 'TMOUT': '86400', 20:07:25 INFO - 'USER': 'cltbld', 20:07:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:25 INFO - '_': '/tools/buildbot/bin/python'} 20:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:07:25 INFO - Cleaning up... 20:07:25 INFO - Return code: 0 20:07:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:25 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 0x7fcf7dfe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, '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': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:07:25 INFO - Using env: {'DISPLAY': ':0', 20:07:25 INFO - 'HOME': '/home/cltbld', 20:07:25 INFO - 'LANG': 'en_US.UTF-8', 20:07:25 INFO - 'LANGUAGE': 'en_US:en', 20:07:25 INFO - 'LOGNAME': 'cltbld', 20:07:25 INFO - 'MAIL': '/var/mail/cltbld', 20:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:25 INFO - 'MOZ_NO_REMOTE': '1', 20:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:25 INFO - 'NO_EM_RESTART': '1', 20:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:25 INFO - 'PWD': '/builds/slave/test', 20:07:25 INFO - 'SHELL': '/bin/bash', 20:07:25 INFO - 'SHLVL': '1', 20:07:25 INFO - 'TERM': 'linux', 20:07:25 INFO - 'TMOUT': '86400', 20:07:25 INFO - 'USER': 'cltbld', 20:07:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:25 INFO - '_': '/tools/buildbot/bin/python'} 20:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:07:25 INFO - Cleaning up... 20:07:25 INFO - Return code: 0 20:07:25 INFO - Running post-action listener: _resource_record_post_action 20:07:25 INFO - Running post-action listener: _start_resource_monitoring 20:07:26 INFO - Starting resource monitoring. 20:07:26 INFO - [mozharness: 2016-10-08 03:07:26.003524Z] Finished create-virtualenv step (success) 20:07:26 INFO - [mozharness: 2016-10-08 03:07:26.003983Z] Running install step. 20:07:26 INFO - Running pre-action listener: _resource_record_pre_action 20:07:26 INFO - Running main action method: install 20:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:26 INFO - Reading from file tmpfile_stdout 20:07:26 INFO - Detecting whether we're running mozinstall >=1.0... 20:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:07:26 INFO - Reading from file tmpfile_stdout 20:07:26 INFO - Output received: 20:07:26 INFO - Usage: mozinstall [options] installer 20:07:26 INFO - Options: 20:07:26 INFO - -h, --help show this help message and exit 20:07:26 INFO - -d DEST, --destination=DEST 20:07:26 INFO - Directory to install application into. [default: 20:07:26 INFO - "/builds/slave/test"] 20:07:26 INFO - --app=APP Application being installed. [default: firefox] 20:07:26 INFO - mkdir: /builds/slave/test/build/application 20:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:07:43 INFO - Reading from file tmpfile_stdout 20:07:43 INFO - Output received: 20:07:43 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:43 INFO - Running post-action listener: _resource_record_post_action 20:07:43 INFO - [mozharness: 2016-10-08 03:07:43.316943Z] Finished install step (success) 20:07:43 INFO - [mozharness: 2016-10-08 03:07:43.317223Z] Running run-tests step. 20:07:43 INFO - Running pre-action listener: _resource_record_pre_action 20:07:43 INFO - Running main action method: run_tests 20:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:43 INFO - Python 2.7.3 20:07:43 INFO - Return code: 0 20:07:43 INFO - grabbing minidump binary from tooltool 20:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d3930>, '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 0x27d4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d4cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:07:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:07:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:07:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:43 INFO - Return code: 0 20:07:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 20:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 20:07:43 INFO - Using env: {'DISPLAY': ':0', 20:07:43 INFO - 'HOME': '/home/cltbld', 20:07:43 INFO - 'LANG': 'en_US.UTF-8', 20:07:43 INFO - 'LANGUAGE': 'en_US:en', 20:07:43 INFO - 'LOGNAME': 'cltbld', 20:07:43 INFO - 'MAIL': '/var/mail/cltbld', 20:07:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:43 INFO - 'MOZ_NO_REMOTE': '1', 20:07:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:43 INFO - 'NO_EM_RESTART': '1', 20:07:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:43 INFO - 'PWD': '/builds/slave/test', 20:07:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:43 INFO - 'SHELL': '/bin/bash', 20:07:43 INFO - 'SHLVL': '1', 20:07:43 INFO - 'TERM': 'linux', 20:07:43 INFO - 'TMOUT': '86400', 20:07:43 INFO - 'USER': 'cltbld', 20:07:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119', 20:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:43 INFO - '_': '/tools/buildbot/bin/python'} 20:07:43 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/1475882408/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 20:07:43 INFO - mozversion application_buildid: 20161007162008 20:07:43 INFO - mozversion application_changeset: c01ac374bce4f4f0b0a7c2f98b7febfe59b1fe97 20:07:43 INFO - mozversion application_display_name: Nightly 20:07:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:43 INFO - mozversion application_name: Firefox 20:07:43 INFO - mozversion application_remotingname: firefox 20:07:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:07:43 INFO - mozversion application_vendor: Mozilla 20:07:43 INFO - mozversion application_version: 52.0a1 20:07:43 INFO - mozversion platform_buildid: 20161007162008 20:07:43 INFO - mozversion platform_changeset: c01ac374bce4f4f0b0a7c2f98b7febfe59b1fe97 20:07:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:07:43 INFO - mozversion platform_version: 52.0a1 20:07:43 INFO - using testdate: 1475896063 20:07:43 INFO - actual date: 1475896063 20:07:43 INFO - starting webserver on 'localhost:43935' 20:07:43 INFO - SUITE-START | Running 2 tests 20:07:43 INFO - TEST-START | dromaeo_css 20:07:43 INFO - operating with platform_type : linux_ 20:07:43 INFO - Initialising browser for dromaeo_css test... 20:07:43 INFO - TEST-INFO | started process 12852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHfy5Ob/profile http://localhost:43935/getInfo.html) 20:07:48 INFO - PROCESS | 12852 | __metrics Screen width/height:1600/1200 20:07:48 INFO - PROCESS | 12852 | colorDepth:24 20:07:48 INFO - PROCESS | 12852 | Browser inner width/height: 1024/697 20:07:48 INFO - PROCESS | 12852 | __metrics 20:07:49 INFO - PROCESS | 12852 | 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" 20:07:49 INFO - PROCESS | 12852 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:49 INFO - PROCESS | 12852 | console.error: PushService: 20:07:49 INFO - PROCESS | 12852 | stateChangeProcessEnqueue: Error transitioning state 20:07:49 INFO - PROCESS | 12852 | UnknownError 20:07:50 INFO - TEST-INFO | 12852: exit 0 20:07:50 INFO - Browser initialized. 20:07:50 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:50 INFO - TEST-INFO | started process 12937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHfy5Ob/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:08:02 INFO - PROCESS | 12937 | RSS: Main: 172658688 20:08:02 INFO - PROCESS | 12937 | 20:08:54 INFO - PROCESS | 12937 | 1475896134147 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:11:04 INFO - PROCESS | 12937 | Cycle 1(1): loaded http://localhost:43935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43935/tests/dromaeo/cssquery-ext.html) 20:11:05 INFO - PROCESS | 12937 | RSS: Main: 327888896 20:11:05 INFO - PROCESS | 12937 | 20:14:08 INFO - PROCESS | 12937 | Cycle 1(1): loaded http://localhost:43935/tests/dromaeo/cssquery-ext.html (next: http://localhost:43935/tests/dromaeo/cssquery-jquery.html) 20:14:08 INFO - PROCESS | 12937 | RSS: Main: 278867968 20:14:08 INFO - PROCESS | 12937 | 20:17:10 INFO - PROCESS | 12937 | Cycle 1(1): loaded http://localhost:43935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43935/tests/dromaeo/cssquery-mootools.html) 20:17:11 INFO - PROCESS | 12937 | RSS: Main: 214446080 20:17:11 INFO - PROCESS | 12937 | 20:20:13 INFO - PROCESS | 12937 | Cycle 1(1): loaded http://localhost:43935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43935/tests/dromaeo/cssquery-prototype.html) 20:20:14 INFO - PROCESS | 12937 | RSS: Main: 232747008 20:20:14 INFO - PROCESS | 12937 | 20:23:16 INFO - PROCESS | 12937 | Cycle 1(1): loaded http://localhost:43935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43935/tests/dromaeo/cssquery-yui.html) 20:23:17 INFO - PROCESS | 12937 | RSS: Main: 219320320 20:23:17 INFO - PROCESS | 12937 | 20:26:19 INFO - PROCESS | 12937 | Cycle 1(1): loaded http://localhost:43935/tests/dromaeo/cssquery-yui.html (next: http://localhost:43935/tests/dromaeo/cssquery-dojo.html) 20:26:20 INFO - PROCESS | 12937 | RSS: Main: 317595648 20:26:20 INFO - PROCESS | 12937 | 20:26:20 INFO - PROCESS | 12937 | __start_tp_report 20:26:20 INFO - PROCESS | 12937 | _x_x_mozilla_page_load 20:26:20 INFO - PROCESS | 12937 | _x_x_mozilla_page_load_details 20:26:20 INFO - PROCESS | 12937 | |i|pagename|runs| 20:26:20 INFO - PROCESS | 12937 | |0;dojo.html;2987.9253018674535;3012.6535448423424;3019.501782205935;3045.2539127913665;3058.418900408922;5071.974640126803;5192.974035129829;5213.139831927732;5276.314079169707;5278.841634750959;5259.684418934867;5271.998320319146;5284.682919024861;5322.2282768998475;5369.033573956686;4755.6908800928;4793.233082706767;4803.519648035186;4818.108649899762;4903.215485522317;4922.926156107661;4956.2565615157655;4964.578010869081;4965.851024469253;4996.500349965011;4655.6973796703105;4686.671932964694;4766.785494652749;4865.464798872139;4913.410390753114;4796.37647105874;4805.735684537349;4808.663393562452;4893.608511319086;4900.044491324194;4764.475907650156;4770.761461926924;4773.952260477386;4795.472498025214;4836.081144582518;5114.079465696173;5146.150885103953;5237.3453318335205;5243.659162154486;5305.867353316159;5602.887942241132;5648.943510564883;5658.236138121342;5668.121441176624;5734.369219385864;5673.6879471629045;5677.489025987639;5695.943040569583;5697.202391665171;5698.145278208261;5150.40770311419;5301.178317360776;5310.309659744247;5316.043112239834;5374.301340825746;5651.463111004448;5742.13867919807;5787.189793428924;5809.24479817621;5890.528757699374;5586.581006424534;5587;5588.0779671354585;5589.720513974285;5591.077472217039;5607.691576963306;5616.297962754656;5661.065924122556;5664.461876121762;5684.175794509773;5430.266913966643;5483.1227003680015;5543.113101903676;5603.243562119062;5604.075327570987;5622.578306626938;5622.803201887996;5625.071863142535;5630.296212973379;5682.715864206773;4354.542773008789;4362.083962367875;4363.258246098171;4401.625861801783;4410.580994805488;3756.6806821420487;3813.389857622767;3817.3892177251505;3829.2341531693774;3860.749051311656;5390.326209223847;5400.945990540123;5401.02781499326;5422.349318081855;5465.043617366945;5649;5690.5447564194765;5702.429757024264;5703.372629010805;5705.914411283834;5196.68819870809;5256.159014557652;5312.2297266896085;5355.625106242525;5421.322334708161;4884.4871288514905;4895.094407534618;4903.828366007244;4959.553640172329;4959.652824302264;5855.238818953509;5900.4099590041515;5915.822525324247;5916.467517923407;5920.378360272195;5517.69652669107;5573.108302671553;5728.312602487562;5729;5730.828075157752;5794.768209271582;5848.795292164754;5848.970755146197;5853.560982926212;5923.348431672599;5507.091329930517;5565.443455654402;5569.66582005081;5586.441355864381;5589.496945274782;5510.393856675682;5693.658380497183;5696.373398926032;5699.088145896637;5699.8860022800145;5415.783368665209;5458.91811622818;5488.094464413487;5516.613837031369;5579.581531385244;5497.092979658311;5501;5503.532199763065;5503.614746967834;5503.7798488061635;5452.781888724407;5498.532624726783;5509.311336082989;5509.917351239655;5574.91637625444;5395.298611180521;5449.100898351886;5524.06090964529;5548.861278468071;5555.388907220122;5403.891922161613;5436.918446223231;5445.50990410865;5454.154606036071;5499.945000549943 20:26:20 INFO - PROCESS | 12937 | |1;ext.html;544.7332583338267;593.8426317025989;600.462585985543;608.628736470753;619.3868070610096;31676.208094797643;32456.675433245662;45597.31604025942;47553.28670069943;47670.76164619172;45641;46013.30980035294;46066.61800145992;46137.53862461374;46155;9027.774305642362;9193.632254709804;9199.586018629145;9209.953950230272;9222.815543689123;9139.040400757924;9245;9252.67615633453;9254.120858518463;9258.444493330422;9204.40171388861;9266.166045055943;9267.397619154766;9271.675491357804;9273.95363023184;9193.172614464696;9238.16856482913;9245.029271926453;9247.907520924771;9250.72247832566;9022.27821774263;9090.68182613612;9091.409058411182;9092.590833412447;9094.545272736403;42819;43159;43185.568144318466;43187.13625727499;43267.783661081805;3645.671889529955;3668.413053911388;3950.4864367632313;4117.855875044359;4147.688923330762;32411.351772964645;32910.670893291;32936.835315823264;33025.50461743076;34241.31517369664;4051.6150965658217;4110.34234522478;4175.937360939588;4355.7822108894425;4364.869053928387;343872;346455;346876;348109;348747;34970.825145874616;36164.63835361613;36168.81915590458;58500;58974.70512647495;37852.62147378546;38023.61976380256;38067.80966095207;38092;38094.23811523754;14059.859401405854;14150.29248537569;14177.503787367392;14177.716445671029;14192.290385480892;11472.713182170346;11531.596394126165;11539.365334906493;11543.018843398237;11546.94226528862;8730.432521886058;8743.781405464788;8759.430637008574;8811.339149563808;8827.249683776823;3317;3337.2491189482657;3377.7297816174646;3385.119868834121;3406.7104296135108;920.4615300049546;1017.6743442098606;1059.4596755654673;1064.8615679961556;1154.5901205072246;30214.69785302163;31768.523472147936;32122.678773212436;32177.656016437948;32396.81750372949;1118.5861231344454;1130.4178348150708;1144.1361771862191;1168.293182624517;1190.9106816988588;15944.267030490202;17003.574910627332;17035.14824258782;17067.743983840253;17175.570610734583;565309;570523;570863;571300;571596;60176.39823601796;60760.69619651962;60771.392286076574;60796.39203607996;60853.39146608566;1213.0962432987305;1245.1781823996118;1271.68207948013;1317.9802302965463;1338.852726200117;30010.69989300079;33879.49180762241;33982.320353593284;34141.48787768136;34296;50992.23511647254;51775.74112129566;51785.741071294404;51788.22317665163;51794.74102629463;409621;411545;414008;414182;414701;25210.36974075663;25864.741352586232;28091.578626320214;28791;29137;47262.527374727186;47462.52537474581;47641.28538072001;47691.284630729875;47714.52285477101;39811.2037759249;40785.388219176144;40785.79607101945;40912.386314205905;41862.58137418709;37930.0517487054;38745.22509549737;39427;39499;39825.40261896016;40294.39558406568;40546.59453405428;40930.590694093866;41289.380659290735;41356.1728765417;32936.01191964245;34719.5768782776;35358.29283414266;35568;36071.81964090163;26794.196174114808;27120.457590848466;27449.30459972857;27465;27621.86189069042 20:26:20 INFO - PROCESS | 12937 | |2;jquery.html;389.7564022485946;392.13534157183415;406.9491313585802;409.5760887481457;417.9435776170216;13285.112114334188;17775.46673599794;18025.278988840448;19807.40577782667;19822.70265946012;15651.921740391283;17086;17817.109144542785;18103.63792724145;18296.817031829676;5070.67040642358;5344.839654810362;5350.571954243651;5367.490088441592;5367.892642147155;5244.711540865251;5392.487713667215;5406.675599464025;5457.399686034533;5461.0716178249795;5363.865903352428;5401.4868587484125;5405.108157154064;5410.91883621746;5414.10667239905;5261.97391508656;5339.786408543654;5397.217403476494;5402.189671549279;5402.837914862541;5253.0544501989625;5268.288781014552;5287.259783630295;5291.312129423189;5292.655977361459;14449.205293708841;14712.411503539846;14821.481248156262;16416.589585260463;22867.542649146922;2142.1110239250693;2203.294945617403;2222.6777117317897;2279.988600057006;2752.3119220194953;9862;10327.638532651396;10626.946865265701;10694.786104277871;10913.563457461692;1850.824171703686;1927.315802889968;1977.8813271203774;1979.5842872996689;1983.0607331043616;87061.12938870657;87112.56443717804;87128;87521.56239218827;90391;10997.670069897917;11093.83359249612;11279.887201128047;11322.886771132347;11412.201145919706;15795.131267780382;15797.709332146775;15832.129232892072;15836.604084897739;15859.889807713349;7002.229754726976;7070.186928503288;7386.2613738625705;7442.553446793209;7935.801604959806;6838.418734407631;6970.0938877946555;7034.8944765828555;7139.643017849086;7181.820454488679;4720.645951553647;4794.5924596408995;4833.03339332128;4943.134951383494;5056.949430505648;1900.3918746001423;1986.2154448992567;1997.5605366819277;2015.3349394699715;2022.5550378916614;877.4779006491127;978.6085565773748;991.1476130527741;1066.925315227942;1070.7644318249972;19578.902105489666;19923.402297931087;20024;20024.89987550053;20271;967.0957654592978;976.6337623391229;989.188865130586;1005.1355833982769;1056.9260151789301;8785.385023048453;10786.352818830896;11183.776324473465;11189.216754827246;11239.55041798319;488950;490387;498522;499926;502836;59210.40789592049;74421.62789186128;79338;97078;98389;1005.4017859373661;1008.7377281906757;1038.5793753529833;1057.2440704896037;1060.506864308085;17245.741313880553;17634;18110.54723631867;18194.545136371697;18426.907865460587;42530.57469425266;42569.78715106405;42639.360409594505;42727.78636106799;42855;59990.80018399695;60362.69818650879;61094;61770;61901;8539.40224184326;8607.397482176188;8730;8831.293496520135;8840.690575830073;11194.776104477702;11995.460204290654;12031.578894738643;12572.937135314265;12680.809787853004;10748.301360411548;11462.083033357478;11470.197086203885;11504.712382190512;11766.529338826693;10231.94884025605;10746.42085899363;10938.617148399768;10996.780064398827;11128.833067503832;10502.789944201226;10749.462526873469;11022.118230541697;11144.498497567467;11923.82114268304;8495.702650407206;8517.659293628185;8572.699955501528;8620;8820.11798820113;10953.452327383759;11365.54537818511;11409.372484513431;11605.825912611486;11725.648230553097 20:26:20 INFO - PROCESS | 12937 | |3;mootools.html;1352.2495015266522;1468.8163979502563;1483.102722852674;1651.314704397675;1766.867484938629;7923.48497347672;8739.082396348387;9052.275817934566;9065.682701105454;9348.392354496953;9116.453012819236;9183.127602877732;9213.907860921388;9217.631294748218;9228.215601673848;2323.314622186459;2350.788429041386;2352.376620195641;2354.3878591566145;2354.81161507079;2327.7323107842644;2338.1933233034574;2380.5119950410126;2380.5119950410212;2384.4277373430427;2330.4639932815376;2338.2166974063625;2346.6597343385197;2377.8811059447044;2382.3210385040265;2222.799948004679;2229.6209644360497;2252.8197744180425;2261.9434514137115;2268.6614897210643;2224.399412158708;2251.200823707593;2252.628316327804;2255.3684968208763;2256.435891027243;8983.146601072887;9058.682946096855;9074.863877041784;9116.5441727914;9194.724158275263;5400.973814975142;5566.248556444909;5568.52667523261;5571.220029195916;5582.7766889324785;3339.34882697874;3372.848221829999;3390.7456940729544;3419.9145021374416;3425.3149370126075;1135.1599816136084;1151.5106079916002;1170.5434880396651;1187.3884949251142;1206.3304865799478;12118.575849845301;12201.26792392468;12219.327936963464;12239.082068844873;12328.753424931541;4325.891852703708;4398.912021759611;4535.705179163344;4544.318352247189;4683.1336202802595;9643.27675424346;9648.903510964941;9660.903390966141;9665.806683866283;9666.420014799134;5268.736563171826;5287.709175995357;5306.389765176977;5313.0967735485065;5315.202719592015;4394.516603173648;4563.95436045642;4701.459332176775;4811.927821082687;4938.234573641092;3704.5739739930254;3771.1891943232336;3792.810359482015;3826.1773718650625;3835.6356146166627;1124.960626378073;1130.1636788776245;1130.8473356096822;1133.4955944604571;1136.9886301137049;863.9179277968709;877.88587483628;880.1462581296132;918.8529835226332;934.4673536084503;5627.071533196977;5647.774089036392;5736.282964629421;5737.598368114275;5843.328017277982;918.1140199707314;920.7559996600907;927.7541451515353;936.4942930817282;1005.9446730429896;3755.4742336072973;3805.1438426353848;3824.827882745283;3835.5972622874756;3982.601739825994;11126.221164518567;11403.144764142722;11500.25248358854;11548.480318385693;11588.304701717923;11436.428178591037;11455.083593312514;11473.254238474472;11473.483693233824;11473.655790326304;7750.263724946121;8154.5514996674565;8167.918320816834;8289.088200297962;8399.664013439517;5717.742701578356;5901.822945311647;5903.291605007426;5907.645541267538;5971.701414929323;10063.496825158567;10245.538950747085;10374.636887708893;10394.740131496774;10419.270651054354;10292.845607316047;10435.217358698279;10442.164626829986;10552.577896884039;10668.30656007357;7281.745138920112;7544.358729508053;7669;7833.1383547808555;7988.720394786154;8674.783130421538;9002.189802917506;9008.189262966365;9013;9019.864702029343;7718.421118416029;7763.72826951054;7881.330086942674;8001.839963200587;8159.673613055411;7634.656440460304;7711.460197786101;7728.8454230916195;7740.380769538311;7841.764747057598;6955.791326260221;6987.8253043672285;7058.788236352918;7064.858702825812;7068.68190931399;4869;4900.362952816111;4929;5004.67376145329;5153.587712983027;4530.841420550265;4663.860084197479;4667.556582124693;4701.7414042228;4802.303665968345 20:26:20 INFO - PROCESS | 12937 | |4;prototype.html;333.3050589520849;341.82396066026;349.1515617050567;351.96128425873167;353.35865404291195;4940.333055037569;5133.768980395882;5154.510321519454;5175.974120129399;5181.481851814821;4948.38145231846;5037.42069661989;5094.7197904115255;5097.847064588059;5122.462141475147;4068;4075.205334959684;4087.1212689271724;4092.0997380576373;4096.139810639769;3814.74929791423;3842.7886466244345;4070.3515076394106;4072.2059198456313;4082.6733861291173;4027.556968733437;4048.1498885234137;4049.574794646564;4051.918961620766;4065.512138543379;4039.5556488786506;4040.1717647882115;4046.3121269384274;4052.169305292408;4064.552899181088;3610.530631017977;3619.1314084619767;3628.546431696038;3630.2920930418577;3632.7820330780237;4825.9034819303415;5022.347094877642;5026.723530205837;5037.622178336603;5039.823606173803;4637.814487420499;4650.395448591696;4659.254519276899;4660.673752837302;4664.5335466453425;5179.482051794828;5346.625736198468;5383.676979381211;5385.838424847261;5395.730213489349;3905.656606036384;3909.1204478992286;3914.846834241156;3926.725129240954;3944.526656801202;5525;5566.387697353288;5568.3596386415675;5571.523546260204;5574.442555744434;3948.170884114311;3998.8492520138343;4053.8986525337104;4054.8986275342763;4059.7767122807936;4048.3117869962175;4055.6477243198874;4111.938320925188;4113.588641135922;4121.319982202903;4585.358049873021;4605.6776025678555;4620.561046700558;4649.976750116295;4679.391679081766;5305.681659100466;5390.9191362129595;5392.654195424924;5424.620276580601;5493.670379777226;1328.8405391353099;1357.3281225793296;1360.632629190133;1391.5199256256576;1404.5505438259863;953.5851904421598;961.1349785193382;971.7279161834698;977.779999500121;987.5259875259916;5181.5854731621375;5187.429382767892;5197.402298735694;5207.765650545734;5209.791608335624;5493.478119578634;5515.117581186991;5516.586256030814;5517.613767036269;5520.613557050968;4989.351384320088;5147.635876492733;5180.870478237999;5194.428612852583;5199.272101905736;2573.716891141973;2579.4523286028234;2591.3521619595103;2594.597837335216;2598.883050262743;4948.88650053735;4966.932109596381;4978.850634480971;5010.198368261061;5022.698638081727;4721.529675688366;4821.445533763592;4904.117258893362;4909.288153217834;4924.482929292372;4916.606671466346;4950.8267210647455;4993.251012348177;4998.200647766801;4998.975005124951;4822.68652537584;4848.539388758062;4868.756562171948;4885.193942999365;4910.495647219872;4529.479109902271;4713.363695901009;4735.526447355237;4772.403449568804;4785.9042819144115;4913.361263035782;4937.481564435826;4994.600431965507;4996.7001979881325;5008.974955125201;3639.181184233632;3646.4684832371;3666.615005424392;3683.576388715332;3688.446732990073;4706.340917381668;4890.6550698558185;4902.43573544023;4905.877353066202;4920.92618610714;4604.447466304065;4685.086408150378;4723.315119307613;4754.5245475452175;4761.547652972962;4720.598749106364;4732.739699316433;4751.667383283275;4775.5463230993;4781.330613714153;4632.976835115803;4653.883652908705;4670.416197975253;4702.506236845082;4800.207965685623;4778;4816.8314109007415;4828.806847726051;4833.7432267609975;4834.196166223652;4609.455832296218;4664.883377915579;4671.672982891165;4678.953210467852;4708.693934894221 20:26:20 INFO - PROCESS | 12937 | |5;yui.html;743.063739687993;749.8575270698567;761.311013532753;787.7636708987307;822.5599304372162;15500.767488487667;16783.076930768802;16797.916010419962;16825.41111061113;16933.491995240147;15197.848021519781;15428.074315541047;15432;15432.69134617307;15435.536933891974;781.1173374087274;794.285143370965;805.1344804335333;805.7864665863551;805.8791181322819;807.0114110214998;809.1867672988639;810.4731924249227;810.5947026486757;810.7081450677751;860.6729442811722;861.2205953611959;861.8491763941286;861.9267362274182;862.1034124510502;835.3818174550819;846.1200351634262;848.5417874347845;848.9278411335013;850.1795767084793;632.0803231298449;632.629911501772;632.8987362022054;633.4425705379236;633.5058654249647;12397.566085186974;12414.193077449936;12426.316552589604;12438.378081096;12444.377781110908;12641.304728239944;13303.536610972786;13445.932770336183;13488.827597233878;13673.31633418335;11088.463512725508;11094.889051109467;11100.833487497694;11295;11327.716807079807;3801.3347664158937;3805.2960202362374;3867.845286188549;3905.258000979805;3937.8031098444962;52754.73622631862;54286.32374753819;59387.70306148485;76013.61993189999;77671.61164194143;11691;11718.589849355401;11774;11925.522979080739;12110.576129835414;20093;21402.357929261834;21538.78461215399;21587.89206053991;21624.56750864974;8700.608472618747;8755.956220218859;8796.604152813139;8880.73357799267;9053.728388148234;4625.861224163281;4787.473377928425;4869.269609558594;4905.754712264444;4960.23116416956;3529.8588056477965;3685.5024571683016;3691.53855768029;3693.538307711536;3698.2788356270808;604.1059232336167;616.950643948483;626.9874602507924;634.9904751428733;649.7530938243532;609.6250805754429;699.4369532526365;706.6325510734389;739.4454159380465;740.4372676765697;9561.426314421156;9564.56959436827;9714.125728684452;9750.171235444925;9803.656872009446;703.4372501998381;711.3171355498779;723.2622724820653;733.3583114774573;745.3887811994113;4578.2903649934315;4708.741019243975;4713.434387873477;4732.787024583902;4829.348038014893;71326.64336678284;71773.28226717666;96896;120708;123194;60497.39502604918;61251.6937415319;62289.68855155695;77335.61332193416;86099;88241.64616953631;88944;89801.55099224462;92079.07920920839;93226.53386733023;9070.501122438329;9253.306002049738;9379.10898464672;9396.295277854051;9455.716328510156;51081.23378149405;51813;52249.738751306;52968;53565.46434535761;69793.65103174452;76079.61960190164;78096.60951695206;78850;80611.59694201492;12772;12941.741165176456;13084.33614620255;13267.601971940858;13700.314984250947;13487.123336983064;14041.859581404055;14082.507112251022;14106;14501.419943202154;12817.871821281668;12925.418356173806;13033.0225233106;13190;13318.800217996932;12438.445194350707;12810.20988085134;12890.871091289342;13515.86484135146;13766.93116534411;12027;12365.938170309451;12539.373031348214;13332;13358;10157.187425005834;10181.541830617492;10305.227107966783;10379;10502.68491945243;10485.737856553647;10806.459677016275;10814.35113893169;10960.835587466036;11033.889661103607 20:26:20 INFO - PROCESS | 12937 | __end_tp_report 20:26:20 INFO - PROCESS | 12937 | __start_cc_report 20:26:20 INFO - PROCESS | 12937 | _x_x_mozilla_cycle_collect,1471 20:26:20 INFO - PROCESS | 12937 | __end_cc_report 20:26:20 INFO - PROCESS | 12937 | __startTimestamp1475897180141__endTimestamp 20:26:20 INFO - PROCESS | 12937 | 20:26:20 INFO - PROCESS | 12937 | ------- Summary: start ------- 20:26:20 INFO - PROCESS | 12937 | Number of tests: 6 20:26:20 INFO - PROCESS | 12937 | 20:26:20 INFO - PROCESS | 12937 | [#0] dojo.html Cycles:165 Average:5253.22 Median:5454.15 stddev:597.77 (11.0%) stddev-sans-first:572.58 20:26:20 INFO - PROCESS | 12937 | Values: 2987.9 3012.7 3019.5 3045.3 3058.4 5072.0 5193.0 5213.1 5276.3 5278.8 5259.7 5272.0 5284.7 5322.2 5369.0 4755.7 4793.2 4803.5 4818.1 4903.2 4922.9 4956.3 4964.6 4965.9 4996.5 4655.7 4686.7 4766.8 4865.5 4913.4 4796.4 4805.7 4808.7 4893.6 4900.0 4764.5 4770.8 4774.0 4795.5 4836.1 5114.1 5146.2 5237.3 5243.7 5305.9 5602.9 5648.9 5658.2 5668.1 5734.4 5673.7 5677.5 5695.9 5697.2 5698.1 5150.4 5301.2 5310.3 5316.0 5374.3 5651.5 5742.1 5787.2 5809.2 5890.5 5586.6 5587.0 5588.1 5589.7 5591.1 5607.7 5616.3 5661.1 5664.5 5684.2 5430.3 5483.1 5543.1 5603.2 5604.1 5622.6 5622.8 5625.1 5630.3 5682.7 4354.5 4362.1 4363.3 4401.6 4410.6 3756.7 3813.4 3817.4 3829.2 3860.7 5390.3 5400.9 5401.0 5422.3 5465.0 5649.0 5690.5 5702.4 5703.4 5705.9 5196.7 5256.2 5312.2 5355.6 5421.3 4884.5 4895.1 4903.8 4959.6 4959.7 5855.2 5900.4 5915.8 5916.5 5920.4 5517.7 5573.1 5728.3 5729.0 5730.8 5794.8 5848.8 5849.0 5853.6 5923.3 5507.1 5565.4 5569.7 5586.4 5589.5 5510.4 5693.7 5696.4 5699.1 5699.9 5415.8 5458.9 5488.1 5516.6 5579.6 5497.1 5501.0 5503.5 5503.6 5503.8 5452.8 5498.5 5509.3 5509.9 5574.9 5395.3 5449.1 5524.1 5548.9 5555.4 5403.9 5436.9 5445.5 5454.2 5499.9 20:26:20 INFO - PROCESS | 12937 | 20:26:20 INFO - PROCESS | 12937 | [#1] ext.html Cycles:180 Average:58995.91 Median:40665.99 stddev:120530.74 (296.4%) stddev-sans-first:120788.96 20:26:20 INFO - PROCESS | 12937 | Values: 544.7 593.8 600.5 608.6 619.4 31676.2 32456.7 45597.3 47553.3 47670.8 45641.0 46013.3 46066.6 46137.5 46155.0 9027.8 9193.6 9199.6 9210.0 9222.8 9139.0 9245.0 9252.7 9254.1 9258.4 9204.4 9266.2 9267.4 9271.7 9274.0 9193.2 9238.2 9245.0 9247.9 9250.7 9022.3 9090.7 9091.4 9092.6 9094.5 42819.0 43159.0 43185.6 43187.1 43267.8 3645.7 3668.4 3950.5 4117.9 4147.7 32411.4 32910.7 32936.8 33025.5 34241.3 4051.6 4110.3 4175.9 4355.8 4364.9 343872.0 346455.0 346876.0 348109.0 348747.0 34970.8 36164.6 36168.8 58500.0 58974.7 37852.6 38023.6 38067.8 38092.0 38094.2 14059.9 14150.3 14177.5 14177.7 14192.3 11472.7 11531.6 11539.4 11543.0 11546.9 8730.4 8743.8 8759.4 8811.3 8827.2 3317.0 3337.2 3377.7 3385.1 3406.7 920.5 1017.7 1059.5 1064.9 1154.6 30214.7 31768.5 32122.7 32177.7 32396.8 1118.6 1130.4 1144.1 1168.3 1190.9 15944.3 17003.6 17035.1 17067.7 17175.6 565309.0 570523.0 570863.0 571300.0 571596.0 60176.4 60760.7 60771.4 60796.4 60853.4 1213.1 1245.2 1271.7 1318.0 1338.9 30010.7 33879.5 33982.3 34141.5 34296.0 50992.2 51775.7 51785.7 51788.2 51794.7 409621.0 411545.0 414008.0 414182.0 414701.0 25210.4 25864.7 28091.6 28791.0 29137.0 47262.5 47462.5 47641.3 47691.3 47714.5 39811.2 40785.4 40785.8 40912.4 41862.6 37930.1 38745.2 39427.0 39499.0 39825.4 40294.4 40546.6 40930.6 41289.4 41356.2 32936.0 34719.6 35358.3 35568.0 36071.8 26794.2 27120.5 27449.3 27465.0 27621.9 20:26:20 INFO - PROCESS | 12937 | 20:26:20 INFO - PROCESS | 12937 | [#2] jquery.html Cycles:180 Average:28804.36 Median:12809.93 stddev:81837.63 (638.9%) stddev-sans-first:82039.39 20:26:20 INFO - PROCESS | 12937 | Values: 389.8 392.1 406.9 409.6 417.9 13285.1 17775.5 18025.3 19807.4 19822.7 15651.9 17086.0 17817.1 18103.6 18296.8 5070.7 5344.8 5350.6 5367.5 5367.9 5244.7 5392.5 5406.7 5457.4 5461.1 5363.9 5401.5 5405.1 5410.9 5414.1 5262.0 5339.8 5397.2 5402.2 5402.8 5253.1 5268.3 5287.3 5291.3 5292.7 14449.2 14712.4 14821.5 16416.6 22867.5 2142.1 2203.3 2222.7 2280.0 2752.3 9862.0 10327.6 10626.9 10694.8 10913.6 1850.8 1927.3 1977.9 1979.6 1983.1 87061.1 87112.6 87128.0 87521.6 90391.0 10997.7 11093.8 11279.9 11322.9 11412.2 15795.1 15797.7 15832.1 15836.6 15859.9 7002.2 7070.2 7386.3 7442.6 7935.8 6838.4 6970.1 7034.9 7139.6 7181.8 4720.6 4794.6 4833.0 4943.1 5056.9 1900.4 1986.2 1997.6 2015.3 2022.6 877.5 978.6 991.1 1066.9 1070.8 19578.9 19923.4 20024.0 20024.9 20271.0 967.1 976.6 989.2 1005.1 1056.9 8785.4 10786.4 11183.8 11189.2 11239.6 488950.0 490387.0 498522.0 499926.0 502836.0 59210.4 74421.6 79338.0 97078.0 98389.0 1005.4 1008.7 1038.6 1057.2 1060.5 17245.7 17634.0 18110.5 18194.5 18426.9 42530.6 42569.8 42639.4 42727.8 42855.0 59990.8 60362.7 61094.0 61770.0 61901.0 8539.4 8607.4 8730.0 8831.3 8840.7 11194.8 11995.5 12031.6 12572.9 12680.8 10748.3 11462.1 11470.2 11504.7 11766.5 10231.9 10746.4 10938.6 10996.8 11128.8 10502.8 10749.5 11022.1 11144.5 11923.8 8495.7 8517.7 8572.7 8620.0 8820.1 10953.5 11365.5 11409.4 11605.8 11725.6 20:26:20 INFO - PROCESS | 12937 | 20:26:20 INFO - PROCESS | 12937 | [#3] mootools.html Cycles:180 Average:5822.12 Median:4692.30 stddev:3389.99 (72.2%) stddev-sans-first:3382.85 20:26:20 INFO - PROCESS | 12937 | Values: 1352.2 1468.8 1483.1 1651.3 1766.9 7923.5 8739.1 9052.3 9065.7 9348.4 9116.5 9183.1 9213.9 9217.6 9228.2 2323.3 2350.8 2352.4 2354.4 2354.8 2327.7 2338.2 2380.5 2380.5 2384.4 2330.5 2338.2 2346.7 2377.9 2382.3 2222.8 2229.6 2252.8 2261.9 2268.7 2224.4 2251.2 2252.6 2255.4 2256.4 8983.1 9058.7 9074.9 9116.5 9194.7 5401.0 5566.2 5568.5 5571.2 5582.8 3339.3 3372.8 3390.7 3419.9 3425.3 1135.2 1151.5 1170.5 1187.4 1206.3 12118.6 12201.3 12219.3 12239.1 12328.8 4325.9 4398.9 4535.7 4544.3 4683.1 9643.3 9648.9 9660.9 9665.8 9666.4 5268.7 5287.7 5306.4 5313.1 5315.2 4394.5 4564.0 4701.5 4811.9 4938.2 3704.6 3771.2 3792.8 3826.2 3835.6 1125.0 1130.2 1130.8 1133.5 1137.0 863.9 877.9 880.1 918.9 934.5 5627.1 5647.8 5736.3 5737.6 5843.3 918.1 920.8 927.8 936.5 1005.9 3755.5 3805.1 3824.8 3835.6 3982.6 11126.2 11403.1 11500.3 11548.5 11588.3 11436.4 11455.1 11473.3 11473.5 11473.7 7750.3 8154.6 8167.9 8289.1 8399.7 5717.7 5901.8 5903.3 5907.6 5971.7 10063.5 10245.5 10374.6 10394.7 10419.3 10292.8 10435.2 10442.2 10552.6 10668.3 7281.7 7544.4 7669.0 7833.1 7988.7 8674.8 9002.2 9008.2 9013.0 9019.9 7718.4 7763.7 7881.3 8001.8 8159.7 7634.7 7711.5 7728.8 7740.4 7841.8 6955.8 6987.8 7058.8 7064.9 7068.7 4869.0 4900.4 4929.0 5004.7 5153.6 4530.8 4663.9 4667.6 4701.7 4802.3 20:26:20 INFO - PROCESS | 12937 | 20:26:20 INFO - PROCESS | 12937 | [#4] prototype.html Cycles:180 Average:4311.50 Median:4758.04 stddev:1204.85 (25.3%) stddev-sans-first:1170.65 20:26:20 INFO - PROCESS | 12937 | Values: 333.3 341.8 349.2 352.0 353.4 4940.3 5133.8 5154.5 5176.0 5181.5 4948.4 5037.4 5094.7 5097.8 5122.5 4068.0 4075.2 4087.1 4092.1 4096.1 3814.7 3842.8 4070.4 4072.2 4082.7 4027.6 4048.1 4049.6 4051.9 4065.5 4039.6 4040.2 4046.3 4052.2 4064.6 3610.5 3619.1 3628.5 3630.3 3632.8 4825.9 5022.3 5026.7 5037.6 5039.8 4637.8 4650.4 4659.3 4660.7 4664.5 5179.5 5346.6 5383.7 5385.8 5395.7 3905.7 3909.1 3914.8 3926.7 3944.5 5525.0 5566.4 5568.4 5571.5 5574.4 3948.2 3998.8 4053.9 4054.9 4059.8 4048.3 4055.6 4111.9 4113.6 4121.3 4585.4 4605.7 4620.6 4650.0 4679.4 5305.7 5390.9 5392.7 5424.6 5493.7 1328.8 1357.3 1360.6 1391.5 1404.6 953.6 961.1 971.7 977.8 987.5 5181.6 5187.4 5197.4 5207.8 5209.8 5493.5 5515.1 5516.6 5517.6 5520.6 4989.4 5147.6 5180.9 5194.4 5199.3 2573.7 2579.5 2591.4 2594.6 2598.9 4948.9 4966.9 4978.9 5010.2 5022.7 4721.5 4821.4 4904.1 4909.3 4924.5 4916.6 4950.8 4993.3 4998.2 4999.0 4822.7 4848.5 4868.8 4885.2 4910.5 4529.5 4713.4 4735.5 4772.4 4785.9 4913.4 4937.5 4994.6 4996.7 5009.0 3639.2 3646.5 3666.6 3683.6 3688.4 4706.3 4890.7 4902.4 4905.9 4920.9 4604.4 4685.1 4723.3 4754.5 4761.5 4720.6 4732.7 4751.7 4775.5 4781.3 4633.0 4653.9 4670.4 4702.5 4800.2 4778.0 4816.8 4828.8 4833.7 4834.2 4609.5 4664.9 4671.7 4679.0 4708.7 20:26:20 INFO - PROCESS | 12937 | 20:26:20 INFO - PROCESS | 12937 | [#5] yui.html Cycles:180 Average:19183.10 Median:4932.99 stddev:26738.29 (542.0%) stddev-sans-first:26777.45 20:26:20 INFO - PROCESS | 12937 | Values: 743.1 749.9 761.3 787.8 822.6 15500.8 16783.1 16797.9 16825.4 16933.5 15197.8 15428.1 15432.0 15432.7 15435.5 781.1 794.3 805.1 805.8 805.9 807.0 809.2 810.5 810.6 810.7 860.7 861.2 861.8 861.9 862.1 835.4 846.1 848.5 848.9 850.2 632.1 632.6 632.9 633.4 633.5 12397.6 12414.2 12426.3 12438.4 12444.4 12641.3 13303.5 13445.9 13488.8 13673.3 11088.5 11094.9 11100.8 11295.0 11327.7 3801.3 3805.3 3867.8 3905.3 3937.8 52754.7 54286.3 59387.7 76013.6 77671.6 11691.0 11718.6 11774.0 11925.5 12110.6 20093.0 21402.4 21538.8 21587.9 21624.6 8700.6 8756.0 8796.6 8880.7 9053.7 4625.9 4787.5 4869.3 4905.8 4960.2 3529.9 3685.5 3691.5 3693.5 3698.3 604.1 617.0 627.0 635.0 649.8 609.6 699.4 706.6 739.4 740.4 9561.4 9564.6 9714.1 9750.2 9803.7 703.4 711.3 723.3 733.4 745.4 4578.3 4708.7 4713.4 4732.8 4829.3 71326.6 71773.3 96896.0 120708.0 123194.0 60497.4 61251.7 62289.7 77335.6 86099.0 88241.6 88944.0 89801.6 92079.1 93226.5 9070.5 9253.3 9379.1 9396.3 9455.7 51081.2 51813.0 52249.7 52968.0 53565.5 69793.7 76079.6 78096.6 78850.0 80611.6 12772.0 12941.7 13084.3 13267.6 13700.3 13487.1 14041.9 14082.5 14106.0 14501.4 12817.9 12925.4 13033.0 13190.0 13318.8 12438.4 12810.2 12890.9 13515.9 13766.9 12027.0 12365.9 12539.4 13332.0 13358.0 10157.2 10181.5 10305.2 10379.0 10502.7 10485.7 10806.5 10814.4 10960.8 11033.9 20:26:20 INFO - PROCESS | 12937 | -------- Summary: end -------- 20:26:20 INFO - PROCESS | 12937 | 20:26:21 INFO - TEST-INFO | 12937: exit 0 20:26:21 INFO - TEST-OK | dromaeo_css | took 1117544ms 20:26:21 INFO - TEST-START | kraken 20:26:21 INFO - operating with platform_type : linux_ 20:26:21 INFO - Initialising browser for kraken test... 20:26:21 INFO - TEST-INFO | started process 13247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyLnpTh/profile http://localhost:43935/getInfo.html) 20:26:26 INFO - PROCESS | 13247 | __metrics Screen width/height:1600/1200 20:26:26 INFO - PROCESS | 13247 | colorDepth:24 20:26:26 INFO - PROCESS | 13247 | Browser inner width/height: 1024/697 20:26:26 INFO - PROCESS | 13247 | __metrics 20:26:26 INFO - PROCESS | 13247 | 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" 20:26:26 INFO - PROCESS | 13247 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:26:27 INFO - PROCESS | 13247 | console.error: PushService: 20:26:27 INFO - PROCESS | 13247 | stateChangeProcessEnqueue: Error transitioning state 20:26:27 INFO - PROCESS | 13247 | UnknownError 20:26:28 INFO - TEST-INFO | 13247: exit 0 20:26:28 INFO - Browser initialized. 20:26:28 INFO - Running cycle 1/1 for kraken test... 20:26:28 INFO - TEST-INFO | started process 13330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyLnpTh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:40 INFO - PROCESS | 13330 | RSS: Main: 172519424 20:26:40 INFO - PROCESS | 13330 | 20:26:42 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43935/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:43 INFO - PROCESS | 13330 | RSS: Main: 230748160 20:26:43 INFO - PROCESS | 13330 | 20:26:46 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43935/tests/kraken/driver.html?testName=audio-dft) 20:26:46 INFO - PROCESS | 13330 | RSS: Main: 216870912 20:26:46 INFO - PROCESS | 13330 | 20:26:49 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43935/tests/kraken/driver.html?testName=audio-fft) 20:26:50 INFO - PROCESS | 13330 | RSS: Main: 297996288 20:26:50 INFO - PROCESS | 13330 | 20:26:52 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43935/tests/kraken/driver.html?testName=audio-oscillator) 20:26:53 INFO - PROCESS | 13330 | RSS: Main: 209739776 20:26:53 INFO - PROCESS | 13330 | 20:26:55 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:56 INFO - PROCESS | 13330 | RSS: Main: 211853312 20:26:56 INFO - PROCESS | 13330 | 20:26:59 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43935/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:59 INFO - PROCESS | 13330 | RSS: Main: 248598528 20:26:59 INFO - PROCESS | 13330 | 20:27:03 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43935/tests/kraken/driver.html?testName=imaging-desaturate) 20:27:03 INFO - PROCESS | 13330 | RSS: Main: 247283712 20:27:03 INFO - PROCESS | 13330 | 20:27:06 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43935/tests/kraken/driver.html?testName=json-parse-financial) 20:27:07 INFO - PROCESS | 13330 | RSS: Main: 246947840 20:27:07 INFO - PROCESS | 13330 | 20:27:08 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:27:09 INFO - PROCESS | 13330 | RSS: Main: 209309696 20:27:09 INFO - PROCESS | 13330 | 20:27:10 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43935/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:27:11 INFO - PROCESS | 13330 | RSS: Main: 217669632 20:27:11 INFO - PROCESS | 13330 | 20:27:13 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:27:14 INFO - PROCESS | 13330 | RSS: Main: 226029568 20:27:14 INFO - PROCESS | 13330 | 20:27:16 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:27:17 INFO - PROCESS | 13330 | RSS: Main: 234594304 20:27:17 INFO - PROCESS | 13330 | 20:27:20 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:27:20 INFO - PROCESS | 13330 | RSS: Main: 231723008 20:27:20 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | Cycle 1(1): loaded http://localhost:43935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43935/tests/kraken/driver.html?testName=ai-astar) 20:27:22 INFO - PROCESS | 13330 | RSS: Main: 282624000 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | __start_tp_report 20:27:22 INFO - PROCESS | 13330 | _x_x_mozilla_page_load 20:27:22 INFO - PROCESS | 13330 | _x_x_mozilla_page_load_details 20:27:22 INFO - PROCESS | 13330 | |i|pagename|runs| 20:27:22 INFO - PROCESS | 13330 | |0;ai-astar;107;110;111;111;111;112;112;110;111;109 20:27:22 INFO - PROCESS | 13330 | |1;audio-beat-detection;145;124;126;166;123;123;124;130;157;126 20:27:22 INFO - PROCESS | 13330 | |2;audio-dft;160;161;161;160;163;163;162;161;162;160 20:27:22 INFO - PROCESS | 13330 | |3;audio-fft;76;76;76;104;76;76;77;77;103;75 20:27:22 INFO - PROCESS | 13330 | |4;audio-oscillator;82;81;125;82;83;82;103;83;83;113 20:27:22 INFO - PROCESS | 13330 | |5;imaging-gaussian-blur;117;117;116;116;117;118;117;117;117;117 20:27:22 INFO - PROCESS | 13330 | |6;imaging-darkroom;145;146;146;146;146;146;147;146;145;145 20:27:22 INFO - PROCESS | 13330 | |7;imaging-desaturate;94;94;95;95;95;95;94;94;94;96 20:27:22 INFO - PROCESS | 13330 | |8;json-parse-financial;53;52;51;51;52;52;52;52;52;56 20:27:22 INFO - PROCESS | 13330 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;62;62;62 20:27:22 INFO - PROCESS | 13330 | |10;stanford-crypto-aes;82;80;80;80;80;80;81;81;79;81 20:27:22 INFO - PROCESS | 13330 | |11;stanford-crypto-ccm;137;137;129;132;128;141;131;131;164;138 20:27:22 INFO - PROCESS | 13330 | |12;stanford-crypto-pbkdf2;168;166;169;164;168;165;168;166;165;172 20:27:22 INFO - PROCESS | 13330 | |13;stanford-crypto-sha256-iterative;68;68;67;66;67;67;68;68;68;70 20:27:22 INFO - PROCESS | 13330 | __end_tp_report 20:27:22 INFO - PROCESS | 13330 | __start_cc_report 20:27:22 INFO - PROCESS | 13330 | _x_x_mozilla_cycle_collect,1654 20:27:22 INFO - PROCESS | 13330 | __end_cc_report 20:27:22 INFO - PROCESS | 13330 | __startTimestamp1475897242762__endTimestamp 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | ------- Summary: start ------- 20:27:22 INFO - PROCESS | 13330 | Number of tests: 14 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.51 (1.4%) stddev-sans-first:0.97 20:27:22 INFO - PROCESS | 13330 | Values: 107.0 110.0 111.0 111.0 111.0 112.0 112.0 110.0 111.0 109.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:128.00 stddev:15.84 (12.4%) stddev-sans-first:16.33 20:27:22 INFO - PROCESS | 13330 | Values: 145.0 124.0 126.0 166.0 123.0 123.0 124.0 130.0 157.0 126.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.13 20:27:22 INFO - PROCESS | 13330 | Values: 160.0 161.0 161.0 160.0 163.0 163.0 162.0 161.0 162.0 160.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:11.56 (15.2%) stddev-sans-first:12.08 20:27:22 INFO - PROCESS | 13330 | Values: 76.0 76.0 76.0 104.0 76.0 76.0 77.0 77.0 103.0 75.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:82.00 stddev:16.04 (19.6%) stddev-sans-first:16.62 20:27:22 INFO - PROCESS | 13330 | Values: 82.0 81.0 125.0 82.0 83.0 82.0 103.0 83.0 83.0 113.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:27:22 INFO - PROCESS | 13330 | Values: 117.0 117.0 116.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 20:27:22 INFO - PROCESS | 13330 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 145.0 145.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 20:27:22 INFO - PROCESS | 13330 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 96.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.42 (2.7%) stddev-sans-first:1.48 20:27:22 INFO - PROCESS | 13330 | Values: 53.0 52.0 51.0 51.0 52.0 52.0 52.0 52.0 52.0 56.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:27:22 INFO - PROCESS | 13330 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.50 stddev:0.84 (1.0%) stddev-sans-first:0.67 20:27:22 INFO - PROCESS | 13330 | Values: 82.0 80.0 80.0 80.0 80.0 80.0 81.0 81.0 79.0 81.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:137.00 stddev:10.48 (7.6%) stddev-sans-first:11.11 20:27:22 INFO - PROCESS | 13330 | Values: 137.0 137.0 129.0 132.0 128.0 141.0 131.0 131.0 164.0 138.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:2.38 (1.4%) stddev-sans-first:2.50 20:27:22 INFO - PROCESS | 13330 | Values: 168.0 166.0 169.0 164.0 168.0 165.0 168.0 166.0 165.0 172.0 20:27:22 INFO - PROCESS | 13330 | 20:27:22 INFO - PROCESS | 13330 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 20:27:22 INFO - PROCESS | 13330 | Values: 68.0 68.0 67.0 66.0 67.0 67.0 68.0 68.0 68.0 70.0 20:27:22 INFO - PROCESS | 13330 | -------- Summary: end -------- 20:27:22 INFO - PROCESS | 13330 | 20:27:24 INFO - TEST-INFO | 13330: exit 0 20:27:24 INFO - TEST-OK | kraken | took 63007ms 20:27:24 INFO - SUITE-END | took 1180s 20:27:24 INFO - Completed test suite (00:19:40) 20:27:24 INFO - javascript benchmark 20:27:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.9253018674535, 3012.6535448423424, 3019.501782205935, 3045.2539127913665, 3058.418900408922, 5071.974640126803, 5192.974035129829, 5213.139831927732, 5276.314079169707, 5278.841634750959, 5259.684418934867, 5271.998320319146, 5284.682919024861, 5322.2282768998475, 5369.033573956686, 4755.6908800928, 4793.233082706767, 4803.519648035186, 4818.108649899762, 4903.215485522317, 4922.926156107661, 4956.2565615157655, 4964.578010869081, 4965.851024469253, 4996.500349965011, 4655.6973796703105, 4686.671932964694, 4766.785494652749, 4865.464798872139, 4913.410390753114, 4796.37647105874, 4805.735684537349, 4808.663393562452, 4893.608511319086, 4900.044491324194, 4764.475907650156, 4770.761461926924, 4773.952260477386, 4795.472498025214, 4836.081144582518, 5114.079465696173, 5146.150885103953, 5237.3453318335205, 5243.659162154486, 5305.867353316159, 5602.887942241132, 5648.943510564883, 5658.236138121342, 5668.121441176624, 5734.369219385864, 5673.6879471629045, 5677.489025987639, 5695.943040569583, 5697.202391665171, 5698.145278208261, 5150.40770311419, 5301.178317360776, 5310.309659744247, 5316.043112239834, 5374.301340825746, 5651.463111004448, 5742.13867919807, 5787.189793428924, 5809.24479817621, 5890.528757699374, 5586.581006424534, 5587.0, 5588.0779671354585, 5589.720513974285, 5591.077472217039, 5607.691576963306, 5616.297962754656, 5661.065924122556, 5664.461876121762, 5684.175794509773, 5430.266913966643, 5483.1227003680015, 5543.113101903676, 5603.243562119062, 5604.075327570987, 5622.578306626938, 5622.803201887996, 5625.071863142535, 5630.296212973379, 5682.715864206773, 4354.542773008789, 4362.083962367875, 4363.258246098171, 4401.625861801783, 4410.580994805488, 3756.6806821420487, 3813.389857622767, 3817.3892177251505, 3829.2341531693774, 3860.749051311656, 5390.326209223847, 5400.945990540123, 5401.02781499326, 5422.349318081855, 5465.043617366945, 5649.0, 5690.5447564194765, 5702.429757024264, 5703.372629010805, 5705.914411283834, 5196.68819870809, 5256.159014557652, 5312.2297266896085, 5355.625106242525, 5421.322334708161, 4884.4871288514905, 4895.094407534618, 4903.828366007244, 4959.553640172329, 4959.652824302264, 5855.238818953509, 5900.4099590041515, 5915.822525324247, 5916.467517923407, 5920.378360272195, 5517.69652669107, 5573.108302671553, 5728.312602487562, 5729.0, 5730.828075157752, 5794.768209271582, 5848.795292164754, 5848.970755146197, 5853.560982926212, 5923.348431672599, 5507.091329930517, 5565.443455654402, 5569.66582005081, 5586.441355864381, 5589.496945274782, 5510.393856675682, 5693.658380497183, 5696.373398926032, 5699.088145896637, 5699.8860022800145, 5415.783368665209, 5458.91811622818, 5488.094464413487, 5516.613837031369, 5579.581531385244, 5497.092979658311, 5501.0, 5503.532199763065, 5503.614746967834, 5503.7798488061635, 5452.781888724407, 5498.532624726783, 5509.311336082989, 5509.917351239655, 5574.91637625444, 5395.298611180521, 5449.100898351886, 5524.06090964529, 5548.861278468071, 5555.388907220122, 5403.891922161613, 5436.918446223231, 5445.50990410865, 5454.154606036071, 5499.945000549943], "value": 5212.428725149402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.7332583338267, 593.8426317025989, 600.462585985543, 608.628736470753, 619.3868070610096, 31676.208094797643, 32456.675433245662, 45597.31604025942, 47553.28670069943, 47670.76164619172, 45641.0, 46013.30980035294, 46066.61800145992, 46137.53862461374, 46155.0, 9027.774305642362, 9193.632254709804, 9199.586018629145, 9209.953950230272, 9222.815543689123, 9139.040400757924, 9245.0, 9252.67615633453, 9254.120858518463, 9258.444493330422, 9204.40171388861, 9266.166045055943, 9267.397619154766, 9271.675491357804, 9273.95363023184, 9193.172614464696, 9238.16856482913, 9245.029271926453, 9247.907520924771, 9250.72247832566, 9022.27821774263, 9090.68182613612, 9091.409058411182, 9092.590833412447, 9094.545272736403, 42819.0, 43159.0, 43185.568144318466, 43187.13625727499, 43267.783661081805, 3645.671889529955, 3668.413053911388, 3950.4864367632313, 4117.855875044359, 4147.688923330762, 32411.351772964645, 32910.670893291, 32936.835315823264, 33025.50461743076, 34241.31517369664, 4051.6150965658217, 4110.34234522478, 4175.937360939588, 4355.7822108894425, 4364.869053928387, 343872.0, 346455.0, 346876.0, 348109.0, 348747.0, 34970.825145874616, 36164.63835361613, 36168.81915590458, 58500.0, 58974.70512647495, 37852.62147378546, 38023.61976380256, 38067.80966095207, 38092.0, 38094.23811523754, 14059.859401405854, 14150.29248537569, 14177.503787367392, 14177.716445671029, 14192.290385480892, 11472.713182170346, 11531.596394126165, 11539.365334906493, 11543.018843398237, 11546.94226528862, 8730.432521886058, 8743.781405464788, 8759.430637008574, 8811.339149563808, 8827.249683776823, 3317.0, 3337.2491189482657, 3377.7297816174646, 3385.119868834121, 3406.7104296135108, 920.4615300049546, 1017.6743442098606, 1059.4596755654673, 1064.8615679961556, 1154.5901205072246, 30214.69785302163, 31768.523472147936, 32122.678773212436, 32177.656016437948, 32396.81750372949, 1118.5861231344454, 1130.4178348150708, 1144.1361771862191, 1168.293182624517, 1190.9106816988588, 15944.267030490202, 17003.574910627332, 17035.14824258782, 17067.743983840253, 17175.570610734583, 565309.0, 570523.0, 570863.0, 571300.0, 571596.0, 60176.39823601796, 60760.69619651962, 60771.392286076574, 60796.39203607996, 60853.39146608566, 1213.0962432987305, 1245.1781823996118, 1271.68207948013, 1317.9802302965463, 1338.852726200117, 30010.69989300079, 33879.49180762241, 33982.320353593284, 34141.48787768136, 34296.0, 50992.23511647254, 51775.74112129566, 51785.741071294404, 51788.22317665163, 51794.74102629463, 409621.0, 411545.0, 414008.0, 414182.0, 414701.0, 25210.36974075663, 25864.741352586232, 28091.578626320214, 28791.0, 29137.0, 47262.527374727186, 47462.52537474581, 47641.28538072001, 47691.284630729875, 47714.52285477101, 39811.2037759249, 40785.388219176144, 40785.79607101945, 40912.386314205905, 41862.58137418709, 37930.0517487054, 38745.22509549737, 39427.0, 39499.0, 39825.40261896016, 40294.39558406568, 40546.59453405428, 40930.590694093866, 41289.380659290735, 41356.1728765417, 32936.01191964245, 34719.5768782776, 35358.29283414266, 35568.0, 36071.81964090163, 26794.196174114808, 27120.457590848466, 27449.30459972857, 27465.0, 27621.86189069042], "value": 18844.67253660643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.7564022485946, 392.13534157183415, 406.9491313585802, 409.5760887481457, 417.9435776170216, 13285.112114334188, 17775.46673599794, 18025.278988840448, 19807.40577782667, 19822.70265946012, 15651.921740391283, 17086.0, 17817.109144542785, 18103.63792724145, 18296.817031829676, 5070.67040642358, 5344.839654810362, 5350.571954243651, 5367.490088441592, 5367.892642147155, 5244.711540865251, 5392.487713667215, 5406.675599464025, 5457.399686034533, 5461.0716178249795, 5363.865903352428, 5401.4868587484125, 5405.108157154064, 5410.91883621746, 5414.10667239905, 5261.97391508656, 5339.786408543654, 5397.217403476494, 5402.189671549279, 5402.837914862541, 5253.0544501989625, 5268.288781014552, 5287.259783630295, 5291.312129423189, 5292.655977361459, 14449.205293708841, 14712.411503539846, 14821.481248156262, 16416.589585260463, 22867.542649146922, 2142.1110239250693, 2203.294945617403, 2222.6777117317897, 2279.988600057006, 2752.3119220194953, 9862.0, 10327.638532651396, 10626.946865265701, 10694.786104277871, 10913.563457461692, 1850.824171703686, 1927.315802889968, 1977.8813271203774, 1979.5842872996689, 1983.0607331043616, 87061.12938870657, 87112.56443717804, 87128.0, 87521.56239218827, 90391.0, 10997.670069897917, 11093.83359249612, 11279.887201128047, 11322.886771132347, 11412.201145919706, 15795.131267780382, 15797.709332146775, 15832.129232892072, 15836.604084897739, 15859.889807713349, 7002.229754726976, 7070.186928503288, 7386.2613738625705, 7442.553446793209, 7935.801604959806, 6838.418734407631, 6970.0938877946555, 7034.8944765828555, 7139.643017849086, 7181.820454488679, 4720.645951553647, 4794.5924596408995, 4833.03339332128, 4943.134951383494, 5056.949430505648, 1900.3918746001423, 1986.2154448992567, 1997.5605366819277, 2015.3349394699715, 2022.5550378916614, 877.4779006491127, 978.6085565773748, 991.1476130527741, 1066.925315227942, 1070.7644318249972, 19578.902105489666, 19923.402297931087, 20024.0, 20024.89987550053, 20271.0, 967.0957654592978, 976.6337623391229, 989.188865130586, 1005.1355833982769, 1056.9260151789301, 8785.385023048453, 10786.352818830896, 11183.776324473465, 11189.216754827246, 11239.55041798319, 488950.0, 490387.0, 498522.0, 499926.0, 502836.0, 59210.40789592049, 74421.62789186128, 79338.0, 97078.0, 98389.0, 1005.4017859373661, 1008.7377281906757, 1038.5793753529833, 1057.2440704896037, 1060.506864308085, 17245.741313880553, 17634.0, 18110.54723631867, 18194.545136371697, 18426.907865460587, 42530.57469425266, 42569.78715106405, 42639.360409594505, 42727.78636106799, 42855.0, 59990.80018399695, 60362.69818650879, 61094.0, 61770.0, 61901.0, 8539.40224184326, 8607.397482176188, 8730.0, 8831.293496520135, 8840.690575830073, 11194.776104477702, 11995.460204290654, 12031.578894738643, 12572.937135314265, 12680.809787853004, 10748.301360411548, 11462.083033357478, 11470.197086203885, 11504.712382190512, 11766.529338826693, 10231.94884025605, 10746.42085899363, 10938.617148399768, 10996.780064398827, 11128.833067503832, 10502.789944201226, 10749.462526873469, 11022.118230541697, 11144.498497567467, 11923.82114268304, 8495.702650407206, 8517.659293628185, 8572.699955501528, 8620.0, 8820.11798820113, 10953.452327383759, 11365.54537818511, 11409.372484513431, 11605.825912611486, 11725.648230553097], "value": 8965.197849284466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.2495015266522, 1468.8163979502563, 1483.102722852674, 1651.314704397675, 1766.867484938629, 7923.48497347672, 8739.082396348387, 9052.275817934566, 9065.682701105454, 9348.392354496953, 9116.453012819236, 9183.127602877732, 9213.907860921388, 9217.631294748218, 9228.215601673848, 2323.314622186459, 2350.788429041386, 2352.376620195641, 2354.3878591566145, 2354.81161507079, 2327.7323107842644, 2338.1933233034574, 2380.5119950410126, 2380.5119950410212, 2384.4277373430427, 2330.4639932815376, 2338.2166974063625, 2346.6597343385197, 2377.8811059447044, 2382.3210385040265, 2222.799948004679, 2229.6209644360497, 2252.8197744180425, 2261.9434514137115, 2268.6614897210643, 2224.399412158708, 2251.200823707593, 2252.628316327804, 2255.3684968208763, 2256.435891027243, 8983.146601072887, 9058.682946096855, 9074.863877041784, 9116.5441727914, 9194.724158275263, 5400.973814975142, 5566.248556444909, 5568.52667523261, 5571.220029195916, 5582.7766889324785, 3339.34882697874, 3372.848221829999, 3390.7456940729544, 3419.9145021374416, 3425.3149370126075, 1135.1599816136084, 1151.5106079916002, 1170.5434880396651, 1187.3884949251142, 1206.3304865799478, 12118.575849845301, 12201.26792392468, 12219.327936963464, 12239.082068844873, 12328.753424931541, 4325.891852703708, 4398.912021759611, 4535.705179163344, 4544.318352247189, 4683.1336202802595, 9643.27675424346, 9648.903510964941, 9660.903390966141, 9665.806683866283, 9666.420014799134, 5268.736563171826, 5287.709175995357, 5306.389765176977, 5313.0967735485065, 5315.202719592015, 4394.516603173648, 4563.95436045642, 4701.459332176775, 4811.927821082687, 4938.234573641092, 3704.5739739930254, 3771.1891943232336, 3792.810359482015, 3826.1773718650625, 3835.6356146166627, 1124.960626378073, 1130.1636788776245, 1130.8473356096822, 1133.4955944604571, 1136.9886301137049, 863.9179277968709, 877.88587483628, 880.1462581296132, 918.8529835226332, 934.4673536084503, 5627.071533196977, 5647.774089036392, 5736.282964629421, 5737.598368114275, 5843.328017277982, 918.1140199707314, 920.7559996600907, 927.7541451515353, 936.4942930817282, 1005.9446730429896, 3755.4742336072973, 3805.1438426353848, 3824.827882745283, 3835.5972622874756, 3982.601739825994, 11126.221164518567, 11403.144764142722, 11500.25248358854, 11548.480318385693, 11588.304701717923, 11436.428178591037, 11455.083593312514, 11473.254238474472, 11473.483693233824, 11473.655790326304, 7750.263724946121, 8154.5514996674565, 8167.918320816834, 8289.088200297962, 8399.664013439517, 5717.742701578356, 5901.822945311647, 5903.291605007426, 5907.645541267538, 5971.701414929323, 10063.496825158567, 10245.538950747085, 10374.636887708893, 10394.740131496774, 10419.270651054354, 10292.845607316047, 10435.217358698279, 10442.164626829986, 10552.577896884039, 10668.30656007357, 7281.745138920112, 7544.358729508053, 7669.0, 7833.1383547808555, 7988.720394786154, 8674.783130421538, 9002.189802917506, 9008.189262966365, 9013.0, 9019.864702029343, 7718.421118416029, 7763.72826951054, 7881.330086942674, 8001.839963200587, 8159.673613055411, 7634.656440460304, 7711.460197786101, 7728.8454230916195, 7740.380769538311, 7841.764747057598, 6955.791326260221, 6987.8253043672285, 7058.788236352918, 7064.858702825812, 7068.68190931399, 4869.0, 4900.362952816111, 4929.0, 5004.67376145329, 5153.587712983027, 4530.841420550265, 4663.860084197479, 4667.556582124693, 4701.7414042228, 4802.303665968345], "value": 4613.066377376168, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.3050589520849, 341.82396066026, 349.1515617050567, 351.96128425873167, 353.35865404291195, 4940.333055037569, 5133.768980395882, 5154.510321519454, 5175.974120129399, 5181.481851814821, 4948.38145231846, 5037.42069661989, 5094.7197904115255, 5097.847064588059, 5122.462141475147, 4068.0, 4075.205334959684, 4087.1212689271724, 4092.0997380576373, 4096.139810639769, 3814.74929791423, 3842.7886466244345, 4070.3515076394106, 4072.2059198456313, 4082.6733861291173, 4027.556968733437, 4048.1498885234137, 4049.574794646564, 4051.918961620766, 4065.512138543379, 4039.5556488786506, 4040.1717647882115, 4046.3121269384274, 4052.169305292408, 4064.552899181088, 3610.530631017977, 3619.1314084619767, 3628.546431696038, 3630.2920930418577, 3632.7820330780237, 4825.9034819303415, 5022.347094877642, 5026.723530205837, 5037.622178336603, 5039.823606173803, 4637.814487420499, 4650.395448591696, 4659.254519276899, 4660.673752837302, 4664.5335466453425, 5179.482051794828, 5346.625736198468, 5383.676979381211, 5385.838424847261, 5395.730213489349, 3905.656606036384, 3909.1204478992286, 3914.846834241156, 3926.725129240954, 3944.526656801202, 5525.0, 5566.387697353288, 5568.3596386415675, 5571.523546260204, 5574.442555744434, 3948.170884114311, 3998.8492520138343, 4053.8986525337104, 4054.8986275342763, 4059.7767122807936, 4048.3117869962175, 4055.6477243198874, 4111.938320925188, 4113.588641135922, 4121.319982202903, 4585.358049873021, 4605.6776025678555, 4620.561046700558, 4649.976750116295, 4679.391679081766, 5305.681659100466, 5390.9191362129595, 5392.654195424924, 5424.620276580601, 5493.670379777226, 1328.8405391353099, 1357.3281225793296, 1360.632629190133, 1391.5199256256576, 1404.5505438259863, 953.5851904421598, 961.1349785193382, 971.7279161834698, 977.779999500121, 987.5259875259916, 5181.5854731621375, 5187.429382767892, 5197.402298735694, 5207.765650545734, 5209.791608335624, 5493.478119578634, 5515.117581186991, 5516.586256030814, 5517.613767036269, 5520.613557050968, 4989.351384320088, 5147.635876492733, 5180.870478237999, 5194.428612852583, 5199.272101905736, 2573.716891141973, 2579.4523286028234, 2591.3521619595103, 2594.597837335216, 2598.883050262743, 4948.88650053735, 4966.932109596381, 4978.850634480971, 5010.198368261061, 5022.698638081727, 4721.529675688366, 4821.445533763592, 4904.117258893362, 4909.288153217834, 4924.482929292372, 4916.606671466346, 4950.8267210647455, 4993.251012348177, 4998.200647766801, 4998.975005124951, 4822.68652537584, 4848.539388758062, 4868.756562171948, 4885.193942999365, 4910.495647219872, 4529.479109902271, 4713.363695901009, 4735.526447355237, 4772.403449568804, 4785.9042819144115, 4913.361263035782, 4937.481564435826, 4994.600431965507, 4996.7001979881325, 5008.974955125201, 3639.181184233632, 3646.4684832371, 3666.615005424392, 3683.576388715332, 3688.446732990073, 4706.340917381668, 4890.6550698558185, 4902.43573544023, 4905.877353066202, 4920.92618610714, 4604.447466304065, 4685.086408150378, 4723.315119307613, 4754.5245475452175, 4761.547652972962, 4720.598749106364, 4732.739699316433, 4751.667383283275, 4775.5463230993, 4781.330613714153, 4632.976835115803, 4653.883652908705, 4670.416197975253, 4702.506236845082, 4800.207965685623, 4778.0, 4816.8314109007415, 4828.806847726051, 4833.7432267609975, 4834.196166223652, 4609.455832296218, 4664.883377915579, 4671.672982891165, 4678.953210467852, 4708.693934894221], "value": 3942.843631726542, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.063739687993, 749.8575270698567, 761.311013532753, 787.7636708987307, 822.5599304372162, 15500.767488487667, 16783.076930768802, 16797.916010419962, 16825.41111061113, 16933.491995240147, 15197.848021519781, 15428.074315541047, 15432.0, 15432.69134617307, 15435.536933891974, 781.1173374087274, 794.285143370965, 805.1344804335333, 805.7864665863551, 805.8791181322819, 807.0114110214998, 809.1867672988639, 810.4731924249227, 810.5947026486757, 810.7081450677751, 860.6729442811722, 861.2205953611959, 861.8491763941286, 861.9267362274182, 862.1034124510502, 835.3818174550819, 846.1200351634262, 848.5417874347845, 848.9278411335013, 850.1795767084793, 632.0803231298449, 632.629911501772, 632.8987362022054, 633.4425705379236, 633.5058654249647, 12397.566085186974, 12414.193077449936, 12426.316552589604, 12438.378081096, 12444.377781110908, 12641.304728239944, 13303.536610972786, 13445.932770336183, 13488.827597233878, 13673.31633418335, 11088.463512725508, 11094.889051109467, 11100.833487497694, 11295.0, 11327.716807079807, 3801.3347664158937, 3805.2960202362374, 3867.845286188549, 3905.258000979805, 3937.8031098444962, 52754.73622631862, 54286.32374753819, 59387.70306148485, 76013.61993189999, 77671.61164194143, 11691.0, 11718.589849355401, 11774.0, 11925.522979080739, 12110.576129835414, 20093.0, 21402.357929261834, 21538.78461215399, 21587.89206053991, 21624.56750864974, 8700.608472618747, 8755.956220218859, 8796.604152813139, 8880.73357799267, 9053.728388148234, 4625.861224163281, 4787.473377928425, 4869.269609558594, 4905.754712264444, 4960.23116416956, 3529.8588056477965, 3685.5024571683016, 3691.53855768029, 3693.538307711536, 3698.2788356270808, 604.1059232336167, 616.950643948483, 626.9874602507924, 634.9904751428733, 649.7530938243532, 609.6250805754429, 699.4369532526365, 706.6325510734389, 739.4454159380465, 740.4372676765697, 9561.426314421156, 9564.56959436827, 9714.125728684452, 9750.171235444925, 9803.656872009446, 703.4372501998381, 711.3171355498779, 723.2622724820653, 733.3583114774573, 745.3887811994113, 4578.2903649934315, 4708.741019243975, 4713.434387873477, 4732.787024583902, 4829.348038014893, 71326.64336678284, 71773.28226717666, 96896.0, 120708.0, 123194.0, 60497.39502604918, 61251.6937415319, 62289.68855155695, 77335.61332193416, 86099.0, 88241.64616953631, 88944.0, 89801.55099224462, 92079.07920920839, 93226.53386733023, 9070.501122438329, 9253.306002049738, 9379.10898464672, 9396.295277854051, 9455.716328510156, 51081.23378149405, 51813.0, 52249.738751306, 52968.0, 53565.46434535761, 69793.65103174452, 76079.61960190164, 78096.60951695206, 78850.0, 80611.59694201492, 12772.0, 12941.741165176456, 13084.33614620255, 13267.601971940858, 13700.314984250947, 13487.123336983064, 14041.859581404055, 14082.507112251022, 14106.0, 14501.419943202154, 12817.871821281668, 12925.418356173806, 13033.0225233106, 13190.0, 13318.800217996932, 12438.445194350707, 12810.20988085134, 12890.871091289342, 13515.86484135146, 13766.93116534411, 12027.0, 12365.938170309451, 12539.373031348214, 13332.0, 13358.0, 10157.187425005834, 10181.541830617492, 10305.227107966783, 10379.0, 10502.68491945243, 10485.737856553647, 10806.459677016275, 10814.35113893169, 10960.835587466036, 11033.889661103607], "value": 7354.356255717381, "unit": "score"}], "name": "dromaeo_css", "value": 7001.58581111196, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 111.0, 111.0, 111.0, 112.0, 112.0, 110.0, 111.0, 109.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 126.0, 166.0, 123.0, 123.0, 124.0, 130.0, 157.0, 126.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 163.0, 163.0, 162.0, 161.0, 162.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 104.0, 76.0, 76.0, 77.0, 77.0, 103.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 125.0, 82.0, 83.0, 82.0, 103.0, 83.0, 83.0, 113.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 96.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0, 56.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 80.0, 80.0, 80.0, 80.0, 81.0, 81.0, 79.0, 81.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 129.0, 132.0, 128.0, 141.0, 131.0, 131.0, 164.0, 138.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 169.0, 164.0, 168.0, 165.0, 168.0, 166.0, 165.0, 172.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 66.0, 67.0, 67.0, 68.0, 68.0, 68.0, 70.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1503.0, "alertThreshold": 2.0}]} 20:27:24 INFO - Return code: 0 20:27:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:27:24 INFO - # TBPL SUCCESS # 20:27:24 INFO - Running post-action listener: _resource_record_post_action 20:27:24 INFO - [mozharness: 2016-10-08 03:27:24.575752Z] Finished run-tests step (success) 20:27:24 INFO - Running post-run listener: _resource_record_post_run 20:27:24 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392658944; Read time: 12; Write time: 384168 20:27:24 INFO - TinderboxPrint: CPU usage
13.1% 20:27:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:27:24 INFO - TinderboxPrint: I/O write bytes / time
392,658,944 / 384,168 20:27:24 INFO - TinderboxPrint: CPU idle
8,302.1 (86.8%) 20:27:24 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 20:27:24 INFO - TinderboxPrint: Swap in / out
0 / 0 20:27:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103858176; Read time: 0; Write time: 134236 20:27:24 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288800768; Read time: 12; Write time: 249932 20:27:25 INFO - Running post-run listener: _upload_blobber_files 20:27:25 INFO - Blob upload gear active. 20:27:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:27:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:27:25 INFO - (blobuploader) - INFO - Open directory for files ... 20:27:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:27:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:27:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:27 INFO - (blobuploader) - INFO - Done attempting. 20:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:30 INFO - (blobuploader) - INFO - Done attempting. 20:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:31 INFO - (blobuploader) - INFO - Done attempting. 20:27:31 INFO - (blobuploader) - INFO - Iteration through files over. 20:27:31 INFO - Return code: 0 20:27:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:27:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:27:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1fcc7941cbb229062868f92189efe9f03c46e35458ba93cb2e5f2929476283fa2780215275e6b5beaaefa8034a20606fb7ef73221039dc2d7abe1d1c36ca836", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a453641abe92686cb9a00053b248e0b90e1232cae1727ba5ae154a9fa209411b9d9cc21b83ea9175a8c7958ae9f868d04e0ee5da9088068786605a89ef4916c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3cffe8b39cf31b649257ff39faef0b529bceb01b7a99999652c8bb2cd546d84de0ba89ab465da9a186b9307f000ad85f859dd7e7cc254632b0d4d90b437998ea"} 20:27:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:27:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:27:31 INFO - Contents: 20:27:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1fcc7941cbb229062868f92189efe9f03c46e35458ba93cb2e5f2929476283fa2780215275e6b5beaaefa8034a20606fb7ef73221039dc2d7abe1d1c36ca836", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a453641abe92686cb9a00053b248e0b90e1232cae1727ba5ae154a9fa209411b9d9cc21b83ea9175a8c7958ae9f868d04e0ee5da9088068786605a89ef4916c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3cffe8b39cf31b649257ff39faef0b529bceb01b7a99999652c8bb2cd546d84de0ba89ab465da9a186b9307f000ad85f859dd7e7cc254632b0d4d90b437998ea"} 20:27:31 INFO - Running post-run listener: copy_logs_to_upload_dir 20:27:31 INFO - Copying logs to upload dir... 20:27:31 INFO - mkdir: /builds/slave/test/build/upload/logs 20:27:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.882258 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-07 20:27:31.097842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 20:27:31.101580) ========= 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=eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119 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/e1fcc7941cbb229062868f92189efe9f03c46e35458ba93cb2e5f2929476283fa2780215275e6b5beaaefa8034a20606fb7ef73221039dc2d7abe1d1c36ca836", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a453641abe92686cb9a00053b248e0b90e1232cae1727ba5ae154a9fa209411b9d9cc21b83ea9175a8c7958ae9f868d04e0ee5da9088068786605a89ef4916c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3cffe8b39cf31b649257ff39faef0b529bceb01b7a99999652c8bb2cd546d84de0ba89ab465da9a186b9307f000ad85f859dd7e7cc254632b0d4d90b437998ea"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1475882408/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/e1fcc7941cbb229062868f92189efe9f03c46e35458ba93cb2e5f2929476283fa2780215275e6b5beaaefa8034a20606fb7ef73221039dc2d7abe1d1c36ca836", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a453641abe92686cb9a00053b248e0b90e1232cae1727ba5ae154a9fa209411b9d9cc21b83ea9175a8c7958ae9f868d04e0ee5da9088068786605a89ef4916c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3cffe8b39cf31b649257ff39faef0b529bceb01b7a99999652c8bb2cd546d84de0ba89ab465da9a186b9307f000ad85f859dd7e7cc254632b0d4d90b437998ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 20:27:31.131958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:27:31.132657) ========= 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=eca2ab57546de7b41f256b19000001ef-1475896009.903452-1947834119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:27:31.212246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 20:27:31.212656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 20:27:31.212953) ========= ========= Total master_lag: 0.19 =========