builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1476949798.76 results: success (0) buildid: 20161020004954 builduid: 559370af74c842b8b70c98834b8ca698 revision: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:58.760173) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:58.760617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:58.760944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:58.810466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:58.810778) ========= 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-1476946743.898202-1939430651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 00:49:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.3M=0s 2016-10-20 00:49:59 (69.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140620 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:58.965795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:58.966129) ========= 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-1476946743.898202-1939430651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021730 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:59.016382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:59.016778) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 --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-1476946743.898202-1939430651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 00:49:59,310 truncating revision to first 12 chars 2016-10-20 00:49:59,310 Setting DEBUG logging. 2016-10-20 00:49:59,310 attempt 1/10 2016-10-20 00:49:59,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/998ad5a74da8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 00:49:59,778 unpacking tar archive at: fx-team-998ad5a74da8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.866600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:59.897531) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:59.897881) ========= script_repo_revision: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:59.898339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:59.898644) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 00:49:59.907686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-20 00:49:59.908004) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:50:00 INFO - MultiFileLogger online at 20161020 00:50:00 in /builds/slave/test 00:50:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:50:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:50:00 INFO - {'append_to_log': False, 00:50:00 INFO - 'base_work_dir': '/builds/slave/test', 00:50:00 INFO - 'blob_upload_branch': 'Fx-Team', 00:50:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:50:00 INFO - 'branch': 'Fx-Team', 00:50:00 INFO - 'buildbot_json_path': 'buildprops.json', 00:50:00 INFO - 'config_files': ('talos/linux_config.py',), 00:50:00 INFO - 'default_actions': ('clobber', 00:50:00 INFO - 'read-buildbot-config', 00:50:00 INFO - 'download-and-extract', 00:50:00 INFO - 'populate-webroot', 00:50:00 INFO - 'create-virtualenv', 00:50:00 INFO - 'install', 00:50:00 INFO - 'run-tests'), 00:50:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:50:00 INFO - 'download_minidump_stackwalk': True, 00:50:00 INFO - 'download_symbols': 'ondemand', 00:50:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:50:00 INFO - 'tooltool.py': '/tools/tooltool.py', 00:50:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:50:00 INFO - '/tools/misc-python/virtualenv.py')}, 00:50:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:50:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:50:00 INFO - 'installer_path': 'installer.exe', 00:50:00 INFO - 'log_level': 'info', 00:50:00 INFO - 'log_name': 'talos', 00:50:00 INFO - 'log_to_console': True, 00:50:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:50:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:50:00 INFO - 'opt_config_files': (), 00:50:00 INFO - 'pip_index': False, 00:50:00 INFO - 'sps_profile': False, 00:50:00 INFO - 'sps_profile_interval': 0, 00:50:00 INFO - 'suite': 'dromaeojs', 00:50:00 INFO - 'system_bits': '32', 00:50:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:50:00 INFO - 'title': 'talos-linux64-ix-010', 00:50:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:50:00 INFO - 'use_talos_json': True, 00:50:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:50:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:50:00 INFO - 'work_dir': 'build'} 00:50:00 INFO - [mozharness: 2016-10-20 07:50:00.301233Z] Running clobber step. 00:50:00 INFO - Running pre-action listener: _resource_record_pre_action 00:50:00 INFO - Running main action method: clobber 00:50:00 INFO - rmtree: /builds/slave/test/build 00:50:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:50:00 INFO - Running post-action listener: _resource_record_post_action 00:50:00 INFO - [mozharness: 2016-10-20 07:50:00.763470Z] Finished clobber step (success) 00:50:00 INFO - [mozharness: 2016-10-20 07:50:00.763573Z] Running read-buildbot-config step. 00:50:00 INFO - Running pre-action listener: _resource_record_pre_action 00:50:00 INFO - Running main action method: read_buildbot_config 00:50:00 INFO - Using buildbot properties: 00:50:00 INFO - { 00:50:00 INFO - "project": "", 00:50:00 INFO - "product": "firefox", 00:50:00 INFO - "script_repo_revision": "production", 00:50:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:50:00 INFO - "repository": "", 00:50:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:50:00 INFO - "buildid": "20161020004954", 00:50:00 INFO - "stage_platform": "linux64-pgo", 00:50:00 INFO - "basedir": "/builds/slave/test", 00:50:00 INFO - "buildnumber": 548, 00:50:00 INFO - "platform": "ubuntu64_hw", 00:50:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:50:00 INFO - "slavebuilddir": "test", 00:50:00 INFO - "branch": "fx-team", 00:50:00 INFO - "revision": "998ad5a74da80fe63664a8dcf30d8f269ffe4e65", 00:50:00 INFO - "slavename": "talos-linux64-ix-010", 00:50:00 INFO - "builduid": "559370af74c842b8b70c98834b8ca698", 00:50:00 INFO - "repo_path": "integration/fx-team" 00:50:00 INFO - } 00:50:00 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:50:00 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 00:50:00 INFO - Running post-action listener: _resource_record_post_action 00:50:00 INFO - [mozharness: 2016-10-20 07:50:00.765941Z] Finished read-buildbot-config step (success) 00:50:00 INFO - [mozharness: 2016-10-20 07:50:00.766031Z] Running download-and-extract step. 00:50:00 INFO - Running pre-action listener: _resource_record_pre_action 00:50:00 INFO - Running main action method: download_and_extract 00:50:00 INFO - mkdir: /builds/slave/test/build/tests 00:50:00 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')]} 00:50:00 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:50:00 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/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 00:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/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 00:50:01 INFO - Downloaded 1361 bytes. 00:50:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:50:01 INFO - Using the following test package requirements: 00:50:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:50:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:50:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:50:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:01 INFO - u'jsshell-linux-x86_64.zip'], 00:50:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:50:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:50:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:50:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:50:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:50:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:50:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:50:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:50:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:50:01 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:50:01 INFO - Http code: 200 00:50:01 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 00:50:01 INFO - x-amz-cf-id: CtLcC9PIofZrH39BI_hWsfeNw17kRcg3ZVgyH_YMkzyRdI_dIE6Idw== 00:50:01 INFO - x-amz-replication-status: COMPLETED 00:50:01 INFO - x-amz-version-id: HdazPYZdvcnREBMlqhyVFuN0JzsOC38l 00:50:04 INFO - Expected file size: 22115879 00:50:04 INFO - Obtained file size: 22115879 00:50:08 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 00:50:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:50:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:50:08 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:50:08 INFO - Http code: 200 00:50:08 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 00:50:08 INFO - x-amz-cf-id: l3KlwxNPmaqDYGi7Dw_7z8IcRZExNevJYGv8xi5XOMeEYNqG8fKdCQ== 00:50:08 INFO - x-amz-replication-status: COMPLETED 00:50:08 INFO - x-amz-version-id: HdazPYZdvcnREBMlqhyVFuN0JzsOC38l 00:50:08 INFO - Expected file size: 22115879 00:50:08 INFO - Obtained file size: 22115879 00:50:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:50:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:50:13 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:50:13 INFO - Http code: 200 00:50:13 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 00:50:13 INFO - x-amz-cf-id: 2c6wEMxkmVI1GksBHF1U6QROhBpXK8yZEBzcWB4IPnH0-Wf60w5FRQ== 00:50:13 INFO - x-amz-replication-status: COMPLETED 00:50:13 INFO - x-amz-version-id: Np3G82iCvSxZv.f4xyoggA_LjV1rFrV_ 00:50:16 INFO - Expected file size: 14409028 00:50:16 INFO - Obtained file size: 14409028 00:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:50:16 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:50:16 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/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 00:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/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 00:50:21 INFO - Downloaded 59503245 bytes. 00:50:21 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:50:21 INFO - mkdir: /builds/slave/test/properties 00:50:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:50:21 INFO - Writing to file /builds/slave/test/properties/build_url 00:50:21 INFO - Contents: 00:50:21 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:50:21 INFO - Running post-action listener: _resource_record_post_action 00:50:21 INFO - Running post-action listener: set_extra_try_arguments 00:50:21 INFO - [mozharness: 2016-10-20 07:50:21.485677Z] Finished download-and-extract step (success) 00:50:21 INFO - [mozharness: 2016-10-20 07:50:21.485957Z] Running populate-webroot step. 00:50:21 INFO - Running pre-action listener: _resource_record_pre_action 00:50:21 INFO - Running main action method: populate_webroot 00:50:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:50:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:50:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:50:21 INFO - '--tppagecycles', 00:50:21 INFO - '7'], 00:50:21 INFO - 'tests': ['tsvgm']}}, 00:50:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:50:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:50:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:50:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:50:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:21 INFO - 'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:50:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:50:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:21 INFO - 'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['damp', 'tps']}, 00:50:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:21 INFO - 'tests': ['damp', 'tps']}, 00:50:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['dromaeo_dom']}, 00:50:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:50:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['basic_compositor_video']}, 00:50:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:50:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['a11yr', 00:50:21 INFO - 'ts_paint', 00:50:21 INFO - 'tpaint', 00:50:21 INFO - 'sessionrestore', 00:50:21 INFO - 'sessionrestore_no_auto_restore', 00:50:21 INFO - 'tabpaint']}, 00:50:21 INFO - 'other-e10s': {'tests': ['a11yr', 00:50:21 INFO - 'ts_paint', 00:50:21 INFO - 'tpaint', 00:50:21 INFO - 'sessionrestore', 00:50:21 INFO - 'sessionrestore_no_auto_restore', 00:50:21 INFO - 'tabpaint']}, 00:50:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:50:21 INFO - 'ts_paint', 00:50:21 INFO - 'tpaint', 00:50:21 INFO - 'sessionrestore', 00:50:21 INFO - 'sessionrestore_no_auto_restore', 00:50:21 INFO - 'tabpaint']}, 00:50:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:50:21 INFO - 'ts_paint', 00:50:21 INFO - 'tpaint', 00:50:21 INFO - 'sessionrestore', 00:50:21 INFO - 'sessionrestore_no_auto_restore', 00:50:21 INFO - 'tabpaint']}, 00:50:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['a11yr', 00:50:21 INFO - 'ts_paint', 00:50:21 INFO - 'tpaint', 00:50:21 INFO - 'sessionrestore', 00:50:21 INFO - 'sessionrestore_no_auto_restore', 00:50:21 INFO - 'tabpaint']}, 00:50:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['a11yr', 00:50:21 INFO - 'ts_paint', 00:50:21 INFO - 'tpaint', 00:50:21 INFO - 'sessionrestore', 00:50:21 INFO - 'sessionrestore_no_auto_restore', 00:50:21 INFO - 'tabpaint']}, 00:50:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['tsvgx', 00:50:21 INFO - 'tsvgr_opacity', 00:50:21 INFO - 'tart', 00:50:21 INFO - 'tscrollx', 00:50:21 INFO - 'cart']}, 00:50:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:50:21 INFO - 'tsvgr_opacity', 00:50:21 INFO - 'tart', 00:50:21 INFO - 'tscrollx', 00:50:21 INFO - 'cart']}, 00:50:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:21 INFO - 'talos_options': ['--disable-e10s'], 00:50:21 INFO - 'tests': ['tp5o']}, 00:50:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:21 INFO - 'tests': ['tp5o']}, 00:50:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:21 INFO - 'talos_options': ['--disable-e10s', 00:50:21 INFO - '--xperf_path', 00:50:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:50:21 INFO - 'tests': ['tp5n']}, 00:50:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:21 INFO - 'talos_options': ['--xperf_path', 00:50:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:50:21 INFO - 'tests': ['tp5n']}}, 00:50:21 INFO - 'talos.zip': {'path': '', 00:50:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:50:21 INFO - Running post-action listener: _resource_record_post_action 00:50:21 INFO - [mozharness: 2016-10-20 07:50:21.509496Z] Finished populate-webroot step (success) 00:50:21 INFO - [mozharness: 2016-10-20 07:50:21.509584Z] Running create-virtualenv step. 00:50:21 INFO - Running pre-action listener: _resource_record_pre_action 00:50:21 INFO - Running main action method: create_virtualenv 00:50:21 INFO - Creating virtualenv /builds/slave/test/build/venv 00:50:21 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 00:50:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:50:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:50:21 INFO - Using real prefix '/usr' 00:50:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:50:22 INFO - Installing distribute.............................................................................................................................................................................................done. 00:50:24 INFO - Installing pip.................done. 00:50:24 INFO - Return code: 0 00:50:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:50:24 INFO - Reading from file tmpfile_stdout 00:50:24 INFO - Output received: 00:50:24 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) 00:50:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:50:24 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')]} 00:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:24 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')]} 00:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:24 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:24 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 00:50:24 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 00:50:24 INFO - Using env: {'DISPLAY': ':0', 00:50:24 INFO - 'HOME': '/home/cltbld', 00:50:24 INFO - 'LANG': 'en_US.UTF-8', 00:50:24 INFO - 'LANGUAGE': 'en_US:en', 00:50:24 INFO - 'LOGNAME': 'cltbld', 00:50:24 INFO - 'MAIL': '/var/mail/cltbld', 00:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:24 INFO - 'MOZ_NO_REMOTE': '1', 00:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:24 INFO - 'NO_EM_RESTART': '1', 00:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:24 INFO - 'PWD': '/builds/slave/test', 00:50:24 INFO - 'SHELL': '/bin/bash', 00:50:24 INFO - 'SHLVL': '1', 00:50:24 INFO - 'TERM': 'linux', 00:50:24 INFO - 'TMOUT': '86400', 00:50:24 INFO - 'USER': 'cltbld', 00:50:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:24 INFO - '_': '/tools/buildbot/bin/python'} 00:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:24 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 00:50:24 INFO - Cleaning up... 00:50:24 INFO - Return code: 0 00:50:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:50:24 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')]} 00:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:24 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')]} 00:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:24 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:24 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 00:50:24 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 00:50:24 INFO - Using env: {'DISPLAY': ':0', 00:50:24 INFO - 'HOME': '/home/cltbld', 00:50:24 INFO - 'LANG': 'en_US.UTF-8', 00:50:24 INFO - 'LANGUAGE': 'en_US:en', 00:50:24 INFO - 'LOGNAME': 'cltbld', 00:50:24 INFO - 'MAIL': '/var/mail/cltbld', 00:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:24 INFO - 'MOZ_NO_REMOTE': '1', 00:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:24 INFO - 'NO_EM_RESTART': '1', 00:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:24 INFO - 'PWD': '/builds/slave/test', 00:50:24 INFO - 'SHELL': '/bin/bash', 00:50:24 INFO - 'SHLVL': '1', 00:50:24 INFO - 'TERM': 'linux', 00:50:24 INFO - 'TMOUT': '86400', 00:50:24 INFO - 'USER': 'cltbld', 00:50:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:24 INFO - '_': '/tools/buildbot/bin/python'} 00:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:24 INFO - Downloading/unpacking psutil>=3.1.1 00:50:24 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 00:50:24 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 00:50:24 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 00:50:24 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 00:50:24 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 00:50:24 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 00:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:50:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:50:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:50:26 INFO - Installing collected packages: psutil 00:50:26 INFO - Running setup.py install for psutil 00:50:26 INFO - building 'psutil._psutil_linux' extension 00:50:26 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 00:50:27 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 00:50:27 INFO - building 'psutil._psutil_posix' extension 00:50:27 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 00:50:27 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 00:50:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:50:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:50:27 INFO - Successfully installed psutil 00:50:27 INFO - Cleaning up... 00:50:27 INFO - Return code: 0 00:50:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:27 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:27 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 00:50:27 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 00:50:27 INFO - Using env: {'DISPLAY': ':0', 00:50:27 INFO - 'HOME': '/home/cltbld', 00:50:27 INFO - 'LANG': 'en_US.UTF-8', 00:50:27 INFO - 'LANGUAGE': 'en_US:en', 00:50:27 INFO - 'LOGNAME': 'cltbld', 00:50:27 INFO - 'MAIL': '/var/mail/cltbld', 00:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:27 INFO - 'MOZ_NO_REMOTE': '1', 00:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:27 INFO - 'NO_EM_RESTART': '1', 00:50:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:27 INFO - 'PWD': '/builds/slave/test', 00:50:27 INFO - 'SHELL': '/bin/bash', 00:50:27 INFO - 'SHLVL': '1', 00:50:27 INFO - 'TERM': 'linux', 00:50:27 INFO - 'TMOUT': '86400', 00:50:27 INFO - 'USER': 'cltbld', 00:50:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:27 INFO - '_': '/tools/buildbot/bin/python'} 00:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:50:27 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 00:50:27 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 00:50:27 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 00:50:27 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 00:50:27 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 00:50:27 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 00:50:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:50:29 INFO - Installing collected packages: mozsystemmonitor 00:50:29 INFO - Running setup.py install for mozsystemmonitor 00:50:29 INFO - Successfully installed mozsystemmonitor 00:50:29 INFO - Cleaning up... 00:50:29 INFO - Return code: 0 00:50:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:50:29 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')]} 00:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:29 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')]} 00:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:29 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:29 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 00:50:29 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 00:50:29 INFO - Using env: {'DISPLAY': ':0', 00:50:29 INFO - 'HOME': '/home/cltbld', 00:50:29 INFO - 'LANG': 'en_US.UTF-8', 00:50:29 INFO - 'LANGUAGE': 'en_US:en', 00:50:29 INFO - 'LOGNAME': 'cltbld', 00:50:29 INFO - 'MAIL': '/var/mail/cltbld', 00:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:29 INFO - 'MOZ_NO_REMOTE': '1', 00:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:29 INFO - 'NO_EM_RESTART': '1', 00:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:29 INFO - 'PWD': '/builds/slave/test', 00:50:29 INFO - 'SHELL': '/bin/bash', 00:50:29 INFO - 'SHLVL': '1', 00:50:29 INFO - 'TERM': 'linux', 00:50:29 INFO - 'TMOUT': '86400', 00:50:29 INFO - 'USER': 'cltbld', 00:50:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:29 INFO - '_': '/tools/buildbot/bin/python'} 00:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:30 INFO - Downloading/unpacking jsonschema==2.5.1 00:50:30 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 00:50:30 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 00:50:30 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 00:50:30 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 00:50:30 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 00:50:30 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 00:50:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:50:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:50:31 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 00:50:31 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 00:50:31 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 00:50:31 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 00:50:31 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 00:50:31 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 00:50:32 INFO - Downloading functools32-3.2.3-2.tar.gz 00:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:50:32 INFO - warning: no files found matching '*.txt' 00:50:32 INFO - no previously-included directories found matching 'build' 00:50:32 INFO - no previously-included directories found matching 'dist' 00:50:32 INFO - no previously-included directories found matching '.git*' 00:50:32 INFO - Installing collected packages: jsonschema, functools32 00:50:32 INFO - Running setup.py install for functools32 00:50:32 INFO - warning: no files found matching '*.txt' 00:50:32 INFO - no previously-included directories found matching 'build' 00:50:32 INFO - no previously-included directories found matching 'dist' 00:50:32 INFO - no previously-included directories found matching '.git*' 00:50:32 INFO - Successfully installed jsonschema functools32 00:50:32 INFO - Cleaning up... 00:50:32 INFO - Return code: 0 00:50:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:50:32 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')]} 00:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:32 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')]} 00:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:32 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:32 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 00:50:32 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 00:50:32 INFO - Using env: {'DISPLAY': ':0', 00:50:32 INFO - 'HOME': '/home/cltbld', 00:50:32 INFO - 'LANG': 'en_US.UTF-8', 00:50:32 INFO - 'LANGUAGE': 'en_US:en', 00:50:32 INFO - 'LOGNAME': 'cltbld', 00:50:32 INFO - 'MAIL': '/var/mail/cltbld', 00:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:32 INFO - 'MOZ_NO_REMOTE': '1', 00:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:32 INFO - 'NO_EM_RESTART': '1', 00:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:32 INFO - 'PWD': '/builds/slave/test', 00:50:32 INFO - 'SHELL': '/bin/bash', 00:50:32 INFO - 'SHLVL': '1', 00:50:32 INFO - 'TERM': 'linux', 00:50:32 INFO - 'TMOUT': '86400', 00:50:32 INFO - 'USER': 'cltbld', 00:50:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:32 INFO - '_': '/tools/buildbot/bin/python'} 00:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:50:32 INFO - Cleaning up... 00:50:32 INFO - Return code: 0 00:50:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:50:32 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')]} 00:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:32 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')]} 00:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:32 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:32 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 00:50:32 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 00:50:32 INFO - Using env: {'DISPLAY': ':0', 00:50:32 INFO - 'HOME': '/home/cltbld', 00:50:32 INFO - 'LANG': 'en_US.UTF-8', 00:50:32 INFO - 'LANGUAGE': 'en_US:en', 00:50:32 INFO - 'LOGNAME': 'cltbld', 00:50:32 INFO - 'MAIL': '/var/mail/cltbld', 00:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:32 INFO - 'MOZ_NO_REMOTE': '1', 00:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:32 INFO - 'NO_EM_RESTART': '1', 00:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:32 INFO - 'PWD': '/builds/slave/test', 00:50:32 INFO - 'SHELL': '/bin/bash', 00:50:32 INFO - 'SHLVL': '1', 00:50:32 INFO - 'TERM': 'linux', 00:50:32 INFO - 'TMOUT': '86400', 00:50:32 INFO - 'USER': 'cltbld', 00:50:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:32 INFO - '_': '/tools/buildbot/bin/python'} 00:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:32 INFO - Downloading/unpacking blobuploader==1.2.4 00:50:32 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 00:50:32 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 00:50:32 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 00:50:32 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 00:50:32 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 00:50:32 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 00:50:34 INFO - Downloading blobuploader-1.2.4.tar.gz 00:50:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:50:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:50:34 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 00:50:34 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 00:50:34 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 00:50:34 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 00:50:34 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 00:50:34 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 00:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:50:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:50:35 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 00:50:35 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 00:50:35 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 00:50:35 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 00:50:35 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 00:50:35 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 00:50:35 INFO - Downloading docopt-0.6.1.tar.gz 00:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:50:35 INFO - Installing collected packages: blobuploader, requests, docopt 00:50:35 INFO - Running setup.py install for blobuploader 00:50:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:50:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:50:35 INFO - Running setup.py install for requests 00:50:36 INFO - Running setup.py install for docopt 00:50:36 INFO - Successfully installed blobuploader requests docopt 00:50:36 INFO - Cleaning up... 00:50:36 INFO - Return code: 0 00:50:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:36 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:36 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 00:50:36 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 00:50:36 INFO - Using env: {'DISPLAY': ':0', 00:50:36 INFO - 'HOME': '/home/cltbld', 00:50:36 INFO - 'LANG': 'en_US.UTF-8', 00:50:36 INFO - 'LANGUAGE': 'en_US:en', 00:50:36 INFO - 'LOGNAME': 'cltbld', 00:50:36 INFO - 'MAIL': '/var/mail/cltbld', 00:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:36 INFO - 'MOZ_NO_REMOTE': '1', 00:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:36 INFO - 'NO_EM_RESTART': '1', 00:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:36 INFO - 'PWD': '/builds/slave/test', 00:50:36 INFO - 'SHELL': '/bin/bash', 00:50:36 INFO - 'SHLVL': '1', 00:50:36 INFO - 'TERM': 'linux', 00:50:36 INFO - 'TMOUT': '86400', 00:50:36 INFO - 'USER': 'cltbld', 00:50:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:36 INFO - '_': '/tools/buildbot/bin/python'} 00:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:50:36 INFO - Running setup.py (path:/tmp/pip-UmEDQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:50:36 INFO - Running setup.py (path:/tmp/pip-dxVmtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:50:36 INFO - Running setup.py (path:/tmp/pip-uf6Ha1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:50:36 INFO - Running setup.py (path:/tmp/pip-apq_DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:50:36 INFO - Running setup.py (path:/tmp/pip-q_I5cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:50:36 INFO - Running setup.py (path:/tmp/pip-GkxNyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:50:36 INFO - Running setup.py (path:/tmp/pip-XroSSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:50:36 INFO - Running setup.py (path:/tmp/pip-0lgUzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:50:36 INFO - Running setup.py (path:/tmp/pip-MR6HrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:50:37 INFO - Running setup.py (path:/tmp/pip-j1PX9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:50:37 INFO - Running setup.py (path:/tmp/pip-tqzaut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:50:37 INFO - Running setup.py (path:/tmp/pip-agwAZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:50:37 INFO - Running setup.py (path:/tmp/pip-fzmn03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:50:37 INFO - Running setup.py (path:/tmp/pip-a5n5xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:50:37 INFO - Running setup.py (path:/tmp/pip-WLB8rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:50:37 INFO - Running setup.py (path:/tmp/pip-OZIzFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:50:37 INFO - Running setup.py (path:/tmp/pip-uN5HC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:50:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:50:37 INFO - Running setup.py install for manifestparser 00:50:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:50:37 INFO - Running setup.py install for mozcrash 00:50:37 INFO - Running setup.py install for mozdebug 00:50:37 INFO - Running setup.py install for mozdevice 00:50:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Running setup.py install for mozfile 00:50:38 INFO - Running setup.py install for mozhttpd 00:50:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Running setup.py install for mozinfo 00:50:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Running setup.py install for mozInstall 00:50:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Running setup.py install for mozleak 00:50:38 INFO - Running setup.py install for mozlog 00:50:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Running setup.py install for moznetwork 00:50:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Running setup.py install for mozprocess 00:50:38 INFO - Running setup.py install for mozprofile 00:50:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:50:38 INFO - Running setup.py install for mozrunner 00:50:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:50:39 INFO - Running setup.py install for mozscreenshot 00:50:39 INFO - Running setup.py install for moztest 00:50:39 INFO - Running setup.py install for mozversion 00:50:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:50:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:50:39 INFO - Cleaning up... 00:50:39 INFO - Return code: 0 00:50:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:39 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:39 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 00:50:39 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 00:50:39 INFO - Using env: {'DISPLAY': ':0', 00:50:39 INFO - 'HOME': '/home/cltbld', 00:50:39 INFO - 'LANG': 'en_US.UTF-8', 00:50:39 INFO - 'LANGUAGE': 'en_US:en', 00:50:39 INFO - 'LOGNAME': 'cltbld', 00:50:39 INFO - 'MAIL': '/var/mail/cltbld', 00:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:39 INFO - 'MOZ_NO_REMOTE': '1', 00:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:39 INFO - 'NO_EM_RESTART': '1', 00:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:39 INFO - 'PWD': '/builds/slave/test', 00:50:39 INFO - 'SHELL': '/bin/bash', 00:50:39 INFO - 'SHLVL': '1', 00:50:39 INFO - 'TERM': 'linux', 00:50:39 INFO - 'TMOUT': '86400', 00:50:39 INFO - 'USER': 'cltbld', 00:50:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:39 INFO - '_': '/tools/buildbot/bin/python'} 00:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:50:39 INFO - Running setup.py (path:/tmp/pip-IMzQlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:50:39 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)) 00:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:50:39 INFO - Running setup.py (path:/tmp/pip-Klqav_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:50:39 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)) 00:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:50:39 INFO - Running setup.py (path:/tmp/pip-Bi3Aw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:50:39 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)) 00:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:50:39 INFO - Running setup.py (path:/tmp/pip-zWJ9fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:50:39 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)) 00:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:50:39 INFO - Running setup.py (path:/tmp/pip-j8oCdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:50:40 INFO - Running setup.py (path:/tmp/pip-zob4KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:50:40 INFO - Running setup.py (path:/tmp/pip-guwwiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:50:40 INFO - Running setup.py (path:/tmp/pip-CNw37f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:50:40 INFO - Running setup.py (path:/tmp/pip-wWfEgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:50:40 INFO - Running setup.py (path:/tmp/pip-IGcAoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:50:40 INFO - Running setup.py (path:/tmp/pip-0FYXPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:50:40 INFO - Running setup.py (path:/tmp/pip-3Cp5eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:50:40 INFO - Running setup.py (path:/tmp/pip-GQ9dDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:50:40 INFO - Running setup.py (path:/tmp/pip-T9WV5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:50:40 INFO - Running setup.py (path:/tmp/pip-TqigMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:50:40 INFO - Running setup.py (path:/tmp/pip-xoViqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:50:40 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)) 00:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:50:40 INFO - Running setup.py (path:/tmp/pip-WDb585-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:50:40 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)) 00:50:40 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)) 00:50:40 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)) 00:50:40 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)) 00:50:40 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)) 00:50:40 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)) 00:50:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:50:40 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 00:50:40 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 00:50:40 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 00:50:40 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 00:50:40 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 00:50:40 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 00:50:42 INFO - Downloading blessings-1.6.tar.gz 00:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:50:42 INFO - Installing collected packages: blessings 00:50:42 INFO - Running setup.py install for blessings 00:50:43 INFO - Successfully installed blessings 00:50:43 INFO - Cleaning up... 00:50:43 INFO - Return code: 0 00:50:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:50:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:50:43 INFO - Reading from file tmpfile_stdout 00:50:43 INFO - Current package versions: 00:50:43 INFO - argparse == 1.2.1 00:50:43 INFO - blessings == 1.6 00:50:43 INFO - blobuploader == 1.2.4 00:50:43 INFO - docopt == 0.6.1 00:50:43 INFO - functools32 == 3.2.3-2 00:50:43 INFO - jsonschema == 2.5.1 00:50:43 INFO - manifestparser == 1.1 00:50:43 INFO - mozInstall == 1.12 00:50:43 INFO - mozcrash == 0.17 00:50:43 INFO - mozdebug == 0.1 00:50:43 INFO - mozdevice == 0.48 00:50:43 INFO - mozfile == 1.2 00:50:43 INFO - mozhttpd == 0.7 00:50:43 INFO - mozinfo == 0.9 00:50:43 INFO - mozleak == 0.1 00:50:43 INFO - mozlog == 3.4 00:50:43 INFO - moznetwork == 0.27 00:50:43 INFO - mozprocess == 0.23 00:50:43 INFO - mozprofile == 0.28 00:50:43 INFO - mozrunner == 6.12 00:50:43 INFO - mozscreenshot == 0.1 00:50:43 INFO - mozsystemmonitor == 0.3 00:50:43 INFO - moztest == 0.7 00:50:43 INFO - mozversion == 1.4 00:50:43 INFO - psutil == 3.1.1 00:50:43 INFO - requests == 1.2.3 00:50:43 INFO - wsgiref == 0.1.2 00:50:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:50: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')]} 00:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50: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')]} 00:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:43 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:43 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 00:50:43 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 00:50:43 INFO - Using env: {'DISPLAY': ':0', 00:50:43 INFO - 'HOME': '/home/cltbld', 00:50:43 INFO - 'LANG': 'en_US.UTF-8', 00:50:43 INFO - 'LANGUAGE': 'en_US:en', 00:50:43 INFO - 'LOGNAME': 'cltbld', 00:50:43 INFO - 'MAIL': '/var/mail/cltbld', 00:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:43 INFO - 'MOZ_NO_REMOTE': '1', 00:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:43 INFO - 'NO_EM_RESTART': '1', 00:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:43 INFO - 'PWD': '/builds/slave/test', 00:50:43 INFO - 'SHELL': '/bin/bash', 00:50:43 INFO - 'SHLVL': '1', 00:50:43 INFO - 'TERM': 'linux', 00:50:43 INFO - 'TMOUT': '86400', 00:50:43 INFO - 'USER': 'cltbld', 00:50:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:43 INFO - '_': '/tools/buildbot/bin/python'} 00:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:43 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)) 00:50:43 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)) 00:50:43 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)) 00:50:43 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)) 00:50:43 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)) 00:50:43 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)) 00:50:43 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)) 00:50:43 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)) 00:50:43 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)) 00:50:43 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)) 00:50:43 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)) 00:50:43 INFO - Cleaning up... 00:50:43 INFO - Return code: 0 00:50:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:50: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')]} 00:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50: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')]} 00:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:43 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 0x7fa8632cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ea7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, '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-1476946743.898202-1939430651', '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 00:50:43 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 00:50:43 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 00:50:43 INFO - Using env: {'DISPLAY': ':0', 00:50:43 INFO - 'HOME': '/home/cltbld', 00:50:43 INFO - 'LANG': 'en_US.UTF-8', 00:50:43 INFO - 'LANGUAGE': 'en_US:en', 00:50:43 INFO - 'LOGNAME': 'cltbld', 00:50:43 INFO - 'MAIL': '/var/mail/cltbld', 00:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:43 INFO - 'MOZ_NO_REMOTE': '1', 00:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:43 INFO - 'NO_EM_RESTART': '1', 00:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:43 INFO - 'PWD': '/builds/slave/test', 00:50:43 INFO - 'SHELL': '/bin/bash', 00:50:43 INFO - 'SHLVL': '1', 00:50:43 INFO - 'TERM': 'linux', 00:50:43 INFO - 'TMOUT': '86400', 00:50:43 INFO - 'USER': 'cltbld', 00:50:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:43 INFO - '_': '/tools/buildbot/bin/python'} 00:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:50:43 INFO - Cleaning up... 00:50:43 INFO - Return code: 0 00:50:43 INFO - Running post-action listener: _resource_record_post_action 00:50:43 INFO - Running post-action listener: _start_resource_monitoring 00:50:43 INFO - Starting resource monitoring. 00:50:43 INFO - [mozharness: 2016-10-20 07:50:43.836674Z] Finished create-virtualenv step (success) 00:50:43 INFO - [mozharness: 2016-10-20 07:50:43.837139Z] Running install step. 00:50:43 INFO - Running pre-action listener: _resource_record_pre_action 00:50:43 INFO - Running main action method: install 00:50:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:50:44 INFO - Reading from file tmpfile_stdout 00:50:44 INFO - Detecting whether we're running mozinstall >=1.0... 00:50:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:50:44 INFO - Reading from file tmpfile_stdout 00:50:44 INFO - Output received: 00:50:44 INFO - Usage: mozinstall [options] installer 00:50:44 INFO - Options: 00:50:44 INFO - -h, --help show this help message and exit 00:50:44 INFO - -d DEST, --destination=DEST 00:50:44 INFO - Directory to install application into. [default: 00:50:44 INFO - "/builds/slave/test"] 00:50:44 INFO - --app=APP Application being installed. [default: firefox] 00:50:44 INFO - mkdir: /builds/slave/test/build/application 00:50:44 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'] 00:50:44 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 00:51:01 INFO - Reading from file tmpfile_stdout 00:51:01 INFO - Output received: 00:51:01 INFO - /builds/slave/test/build/application/firefox/firefox 00:51:01 INFO - Running post-action listener: _resource_record_post_action 00:51:01 INFO - [mozharness: 2016-10-20 07:51:01.201414Z] Finished install step (success) 00:51:01 INFO - [mozharness: 2016-10-20 07:51:01.201689Z] Running run-tests step. 00:51:01 INFO - Running pre-action listener: _resource_record_pre_action 00:51:01 INFO - Running main action method: run_tests 00:51:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:51:01 INFO - Python 2.7.3 00:51:01 INFO - Return code: 0 00:51:01 INFO - grabbing minidump binary from tooltool 00:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:01 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 0x2a79790>, '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 0x2a7a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:51:01 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 00:51:01 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 00:51:01 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 00:51:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:51:01 INFO - Return code: 0 00:51:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:51:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:51:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:51:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:51:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:51:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/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 00:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/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 00:51:01 INFO - Using env: {'DISPLAY': ':0', 00:51:01 INFO - 'HOME': '/home/cltbld', 00:51:01 INFO - 'LANG': 'en_US.UTF-8', 00:51:01 INFO - 'LANGUAGE': 'en_US:en', 00:51:01 INFO - 'LOGNAME': 'cltbld', 00:51:01 INFO - 'MAIL': '/var/mail/cltbld', 00:51:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:51:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:01 INFO - 'MOZ_NO_REMOTE': '1', 00:51:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:01 INFO - 'NO_EM_RESTART': '1', 00:51:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:01 INFO - 'PWD': '/builds/slave/test', 00:51:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:51:01 INFO - 'SHELL': '/bin/bash', 00:51:01 INFO - 'SHLVL': '1', 00:51:01 INFO - 'TERM': 'linux', 00:51:01 INFO - 'TMOUT': '86400', 00:51:01 INFO - 'USER': 'cltbld', 00:51:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476946743.898202-1939430651', 00:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:01 INFO - '_': '/tools/buildbot/bin/python'} 00:51:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/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 00:51:01 INFO - mozversion application_buildid: 20161019213008 00:51:01 INFO - mozversion application_changeset: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 00:51:01 INFO - mozversion application_display_name: Nightly 00:51:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:51:01 INFO - mozversion application_name: Firefox 00:51:01 INFO - mozversion application_remotingname: firefox 00:51:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:51:01 INFO - mozversion application_vendor: Mozilla 00:51:01 INFO - mozversion application_version: 52.0a1 00:51:01 INFO - mozversion platform_buildid: 20161019213008 00:51:01 INFO - mozversion platform_changeset: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 00:51:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:51:01 INFO - mozversion platform_version: 52.0a1 00:51:01 INFO - using testdate: 1476949861 00:51:01 INFO - actual date: 1476949861 00:51:01 INFO - starting webserver on 'localhost:39459' 00:51:01 INFO - SUITE-START | Running 2 tests 00:51:01 INFO - TEST-START | dromaeo_css 00:51:01 INFO - operating with platform_type : linux_ 00:51:01 INFO - Initialising browser for dromaeo_css test... 00:51:01 INFO - TEST-INFO | started process 4101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5pAkE/profile http://localhost:39459/getInfo.html) 00:51:05 INFO - PROCESS | 4101 | __metrics Screen width/height:1600/1200 00:51:05 INFO - PROCESS | 4101 | colorDepth:24 00:51:05 INFO - PROCESS | 4101 | Browser inner width/height: 1024/697 00:51:05 INFO - PROCESS | 4101 | __metrics 00:51:06 INFO - PROCESS | 4101 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:51:06 INFO - PROCESS | 4101 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:51:07 INFO - PROCESS | 4101 | console.error: PushService: 00:51:07 INFO - PROCESS | 4101 | stateChangeProcessEnqueue: Error transitioning state 00:51:07 INFO - PROCESS | 4101 | UnknownError 00:51:08 INFO - TEST-INFO | 4101: exit 0 00:51:08 INFO - Browser initialized. 00:51:08 INFO - Running cycle 1/1 for dromaeo_css test... 00:51:08 INFO - TEST-INFO | started process 4185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5pAkE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:51:20 INFO - PROCESS | 4185 | RSS: Main: 171839488 00:51:20 INFO - PROCESS | 4185 | 00:52:11 INFO - PROCESS | 4185 | 1476949931161 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] 00:54:21 INFO - PROCESS | 4185 | Cycle 1(1): loaded http://localhost:39459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39459/tests/dromaeo/cssquery-ext.html) 00:54:24 INFO - PROCESS | 4185 | RSS: Main: 412692480 00:54:24 INFO - PROCESS | 4185 | 00:57:27 INFO - PROCESS | 4185 | Cycle 1(1): loaded http://localhost:39459/tests/dromaeo/cssquery-ext.html (next: http://localhost:39459/tests/dromaeo/cssquery-jquery.html) 00:57:28 INFO - PROCESS | 4185 | RSS: Main: 279068672 00:57:28 INFO - PROCESS | 4185 | 01:00:30 INFO - PROCESS | 4185 | Cycle 1(1): loaded http://localhost:39459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39459/tests/dromaeo/cssquery-mootools.html) 01:00:30 INFO - PROCESS | 4185 | RSS: Main: 254390272 01:00:30 INFO - PROCESS | 4185 | 01:03:32 INFO - PROCESS | 4185 | Cycle 1(1): loaded http://localhost:39459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39459/tests/dromaeo/cssquery-prototype.html) 01:03:33 INFO - PROCESS | 4185 | RSS: Main: 274657280 01:03:33 INFO - PROCESS | 4185 | 01:06:36 INFO - PROCESS | 4185 | Cycle 1(1): loaded http://localhost:39459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39459/tests/dromaeo/cssquery-yui.html) 01:06:36 INFO - PROCESS | 4185 | RSS: Main: 220364800 01:06:36 INFO - PROCESS | 4185 | 01:09:39 INFO - PROCESS | 4185 | Cycle 1(1): loaded http://localhost:39459/tests/dromaeo/cssquery-yui.html (next: http://localhost:39459/tests/dromaeo/cssquery-dojo.html) 01:09:39 INFO - PROCESS | 4185 | RSS: Main: 316137472 01:09:39 INFO - PROCESS | 4185 | 01:09:39 INFO - PROCESS | 4185 | __start_tp_report 01:09:39 INFO - PROCESS | 4185 | _x_x_mozilla_page_load 01:09:39 INFO - PROCESS | 4185 | _x_x_mozilla_page_load_details 01:09:39 INFO - PROCESS | 4185 | |i|pagename|runs| 01:09:39 INFO - PROCESS | 4185 | |0;dojo.html;3110.626724793025;3133.263683034485;3161.557381966524;3181.570487984123;3183.3633273345336;5332.200169974506;5374.220737992989;5409.891802163955;5450.809221677242;5517.36550296716;5445.156000819879;5445.891082178354;5477.726113694319;5479.0959491683825;5495.038368285554;4901.828436004741;4913.729744864022;4940.234263689116;4965.3048573199785;4991.425986011601;4871.439784424783;5015.197568389059;5015.724135172564;5052.242163675442;5057.115004874132;5061.974690126544;5070.264811602316;5073.644844860862;5084.491550844923;5132.5124113209185;4251.766152861592;4962.6526143169995;5059.215821547666;5059.241113832918;5063.265826455144;4817.494163112858;4864;4967.205247160437;4986.077575648516;5011.448740638527;5338.252644629755;5367.946320536784;5436.809711660073;5450.509454149145;5521.254630624854;5754.913676294859;5754.97122514389;5758.74085666146;5802.245708057968;5898.616589921641;5876.6180198286975;5882.2353094097925;5898.233229680114;5898.41015898411;5904.114382842565;5312.362516498045;5343.572514198855;5425.159100339453;5475;5481.451854814526;5939.168516407706;5954.07711804671;5970.701464926737;5971.0744834550715;6031.8793624127275;5738.483536481736;5738.8278351649515;5742.569307301969;5747.540196784247;5748.223989761329;5638.154276858422;5680.375158732536;5752.165935939265;5825.1844741736195;5828.59199856006;5760.913586296209;5791.623544469596;5857.0335894577765;5857.47282744555;5862.179294898718;5795.333536643256;5798.94201057984;5800.158976948319;5801.9129713054335;5803.82588522345;4308.482982042112;4370.125974805052;4386.627136693417;4454.376387305715;4454.443194600675;3950.328444164499;3958.366661334173;3959.8020098994934;3977.184677141237;4032.6169013943627;5521.282233309644;5527.060399731975;5534;5538.418466061005;5555.416681248492;5671.546276297886;5824.068149096124;5841.7371218295275;5842.59101862874;5850.531957443394;5300.12547929595;5305.973470132624;5340.145576707708;5351.81268655603;5451.700156491352;4917.0903382874285;4920.507949205123;4922.237053256751;4922.237053256751;4994.225894986283;5862.648241105548;5868.823935281948;5872.060470324727;5872.471477567039;5878.941210587839;5556.444355564573;5683.2895888014;5767.826965191051;5812.854678633068;5816.534677225896;5986.371430999682;6035.78874739382;6037.154798328325;6037.728302226323;6098.664573448503;5689.829305120853;5727.198192253005;5727.742251598771;5729.9713501432225;5731.8567035824435;5650.378458369658;5677.772889084556;5708.543316534584;5796.362400135898;5824.388439213991;5662.462066103713;5671.773129074791;5673.092305231144;5676.858078547904;5679.0345641240265;5646.040173170489;5650.29371328584;5661.150827375762;5662.57530685192;5663.716814159193;5626.35296940857;5655.858603534944;5661.830145095653;5666.405027472056;5668.404817494104;5689.175069614966;5698.287714035746;5705.743241554057;5732.05421105513;5737.598368114359;5531.668099914018;5532.391436942014;5582.720863956867;5603;5608.691521966331 01:09:39 INFO - PROCESS | 4185 | |1;ext.html;572.7508533787801;592.5792687192094;596.3380647481295;603.2007589943327;604.5949214026605;31637.68362316376;42894.785526072366;44356.99999999992;44359.999999999956;47703.76148119263;44519.77740111303;45132;45136.77431612845;45213.547864521344;45220.54779452205;8011.599420029004;8633.3524985626;8814.382993190478;8819.867701984444;8831.646734130627;7694.461387702835;10239.436830974293;10537.104346130589;10546.736331591695;10805.675829725122;10692.78614427711;10753.193510486706;10753.569857205703;10762.139028877671;10764.677059688183;10525.684229473129;10526.9473652632;10583.947080264588;10586.947065264701;10599.470026498644;10388.065074143364;10444.26890117692;10446.947765261126;10461.424621645807;10466.424346660931;41609.37585936213;41859.372109418386;41875.58124418747;41919;41934;3263.216827961296;3393.2874096439778;3724.627537246281;4016.9196616067516;4072.450219220397;30809;31668.733250669946;31853.203669908205;31865;31957.52063719046;4169.854055108087;4248.575142485757;4279.1869544786705;4325.437693099877;4348.90237743959;221328;224159;224177;224319.3920151993;224385;55854.162187566406;56158;56177.15734263989;56261.718691406284;56346.154807677915;58682.41317586855;58742.11886821701;58777.4122258772;58824.70587647035;58871.70564147152;14473;14499.202543859978;14508.274586270643;14549;14558.41766329335;11431.314121152758;11662.88337116635;12750.744985100246;13119;13194.934025330003;15136.772948405562;15532;15642.530724078295;15662.295196715948;15721.528354149394;6089.995150800157;6308.243010838729;6314.684265786692;6445.1943507061615;6503.512236582275;950.6245033211843;1029.433811403725;1037.0148359058774;1053.4206186597341;1062.3731998121145;29764.34578467211;30168.54747178794;30269.545956810667;30639.69360306413;31216.37567248642;1057.2546354819833;1079.1205167788228;1080.4543705428866;1094.5567045346647;1124.1681155944543;15457;16317.918410408109;16362.729946657408;16375.344986200656;16563.83436165647;454237;454972;455939;456961;458467;56387;56660.15009774857;56722.71638641781;56755.43244567584;56792.71603642038;1198.1493139870615;1220.4934951995178;1226.1845872494869;1324.1260767893145;1352.3576301256824;29948.70051299459;33185.83407082949;33243.66756332406;33382.83308583441;33712.49431258582;52381.47618523766;52997.735011324694;53204.20193697175;53225.20162197648;53298.733506333774;430397;434460;435490;435590;436663;25694.100706475183;26474.205773826816;26551.203463896112;38731.41902871403;39095.41356879706;38313.233735325695;38485;39375.40936885892;43123.784381077894;46328;38856.6114338853;40065.399019014156;40134.79932600318;40761.79619101885;41834.372484412146;36732.44901326536;36810.447843281836;36915.63084369122;36952.44571331486;37281.44077838889;39081.413778792776;39146.804265978484;39659.80170099131;40297.395539067526;40501.79749101236;33476.83261583676;35309.646903530636;36227.27545449129;36229.456558152175;36510.4523432154;27020;27455.17634470969;27491.450170996868;27499.725002749718;27521 01:09:39 INFO - PROCESS | 4185 | |2;jquery.html;370.8739028730231;378.92915218331814;385.2545324796519;400.94587230723846;406.7051387743886;14470.927645361759;15118.546443606681;17098.5725356866;19802.70295945562;20234.494137646547;15411.845881541181;17906.283748650072;18292.268309267612;18312.542186445346;19076.23695052196;5592.328920529532;5833.358330583633;5833.562482813806;5837.24115864937;5837.824865254049;5034.892323688782;5727.169560413738;5756.079027355603;5786.9710651446685;5787.652740835542;5613.242212301348;5739.397363276858;5756.712164391784;5757.884842303151;5757.971210143944;5476.397596264408;5594.636348637346;5603.3836278009385;5614.214010038598;5622.381538030813;4970.950290497121;5002.274670172841;5006.4743201964;5010.123228435045;5012.573931215851;13220.272884991322;13425.597232083053;20729.27447539344;21813.0184141714;22658.77341226583;2225.265662331427;2357.3635118518077;2761.278214253629;2775.34779326858;2783.5128852450944;9698.70903872885;9723.124918757276;9770;10055.446950417723;12057.57798477049;1819.4814477873742;1863.2174486715612;1872.1668857358482;1920.7407000055093;1927.226951204895;76019.61990190069;80700.59649701713;82463.56887544716;85101.57449212714;85189;9951.701448956543;9961.452120133317;10043.397396156253;10248.795024099625;10374.27380083402;13892;13915.721685566232;13918.652033699036;13922.791158132635;13937.233452160026;7610.4672672913475;7812.648430820626;7870;8013.639386227634;8105.716299929592;7730.613469326511;7737.381009519225;7794.921006202631;7925.682972681028;7979.162187970295;4217.325227963511;4253.234417804763;4297.892552686208;4353.956460435355;4368.934465983013;1854.7959724430573;1855.7030875060195;1856.5358660334916;1883.227876570627;1934.951626209356;424.61572277089283;850.910654381281;944.504135328944;988.980220395588;1038.4911393417171;10356.223283253787;11168.832467512993;11377.37424441647;11426.371549564854;11487.712807179887;448.6455699996966;455.14660012476605;473.18375801742405;473.9857804265878;475.28944228378106;5708.058170401837;5723.8855222896145;6159.876802463926;6160.322364539897;6191.854506916235;476015;478245;480762.5389968794;480985;483193;75340.62329688427;92343;92561;92943.53528232315;93111;453.555515594719;467.43440437071524;467.7474163951496;468.96951698139515;468.9765511724468;10359.844602331123;10466.738331541772;10725.89274107249;10732.851590843506;10890;40507.59492405038;40877.79561102294;41071.38392924049;42197.367039495046;42511.574884252;50824.74587627038;51501.7424912873;51535.48464515307;58910.41089589049;62440.68779656073;8109.107998120084;8217.424780265324;8283.710070147516;8426.241638252586;8551;9352.53237338144;11115.72210694739;11852.76294474123;11989.64031079069;12510.437030333474;10816.891831081903;10827.646544181976;10853.891461085288;11155.163362747664;11281.32312061279;10368.740781480523;10738.248322617343;11020.283681560673;11059.22585419013;11369.772604548029;10916.890831091587;10955.616553420592;10961.83557246626;11000.724981875517;11277;7806.336461400844;7871.881921771293;10817.593712817283;10920.890791092304;11359.318440893572;11299.43502824839;11616.16666500036;12606.432710527864;12692.301923394301;12693.238405695687 01:09:39 INFO - PROCESS | 4185 | |3;mootools.html;1352.8162857499688;1448.1673038003148;1488.8064551608288;1617.2722274976263;1762.3215062201048;7815.726449574259;8338.082810890804;8648.264897483721;8657.047724750288;8905.376623636348;8719.912800871989;8786.20924116831;8790.780230494242;8797.38418310717;8799.692010779623;2299.034405549669;2326.7324257710325;2327.0924339507606;2328.511012687329;2330.3475026992382;2273.2839155665997;2307.561563302967;2325.697659304288;2327.697399338092;2334.8482348647367;2264.762199969004;2291.7249930008425;2301.413139649387;2315.235972129202;2319.4085508195385;2251.538434620899;2259.367377134405;2292.5529521743265;2298.184144628658;2301.4821665125464;2259;2296.6784650148993;2296.70142881426;2299.344686764281;2299.494111295512;8898.644054237822;9034.412763170372;9088.636454541811;9089.409188402733;9098.545072746403;5412.269343638637;5556.749946252428;5558.77764889408;5562.833115006556;5564;3366.208940898887;3392.7116195123444;3429.2798512312443;3438.0889064397707;3471.427214509603;1061.930974486656;1068.3483075324045;1083.1767856429092;1095.4030053620795;1124;12268.202566833128;12354.876451235463;12510.687232819162;12537.623871283877;12550.81173782394;4296.91406171881;4457.442819647544;4579.633629309647;4596.6322694185055;4598.563136502027;9767.120959113714;9768.755781105387;9779.168770654433;9780.315377923476;9784.755381115529;5331.86670333237;5334.226537152169;5334.253204551366;5334.653247538898;5335.706536140549;4367.388565600819;4488.708233964782;4797.712137271705;4888.144574699484;4999.700017998932;3730.4404339349317;3770.7171962102952;3804.923901521954;3845.2309538092495;3854.8265328060306;1158.507634255438;1178.929264244148;1196.8085106383112;1197.898178654824;1201.159188568006;808.5754978636263;886.2688282167109;902.1970446302664;915.3546749541557;933.8785957825439;5490.752916118784;5519.365272993577;5641.153826925994;5702;5706.971465142731;413.1736526946108;423.3163441042694;426.3455595660646;427.19686988462115;432.55662945481134;3562.697170740516;3710.1466662667735;3722.553293604785;3742.2515496900182;3848.615138486129;11124.388158651353;11417.714557136138;11448.427578621036;11459.541618335339;11561.479733412016;11070.114390848712;11268.267562608404;11382.203245772716;11387;11392.601258955896;8127.3091787198755;8304.792380190424;8384.329253659693;8396.160383961555;8399.28606068491;5457.508824205841;5479.178123281539;5488.17677348401;5536.446355364431;5715.199872017838;10062.597496100074;10185.49072546355;10234.6417875374;10269.53787079598;10344.741381465523;10102.78766548019;10362.844557331495;10639.14886809069;10699.839502407314;10707.89292107069;6822.11312529368;7011.298870112948;7225.674844631899;7505.362044226302;7562.2437756223935;8281;8737.126287371466;8744.213020828156;8745.737627871174;8746.431481953652;7405.259474052552;7463.626818659154;7468.887966680612;7536.8492630148185;7828.412869034732;7218;7411.518251313647;7532.945387645844;7540.057492813398;7674.923250767644;6493.253275873335;6593.977933420328;6603.669816509059;6632.734690612321;6677.933220667731;4832.613390928647;4840.056189043103;4876.024795040935;4914.680545764514;5118.257852611276;4933.309336692794;4968.205087186033;4989.72556509381;5046.899062018812;5105.540501354896 01:09:39 INFO - PROCESS | 4185 | |4;prototype.html;311.5389223948558;320.99839500802494;329.0687354785956;329.7839914855769;331.23154282065605;4720.480747117823;4950.895869255561;5220.477952204782;5230.2416149658275;5254.658447200929;5096.413912400066;5185.029688718282;5190.740462976855;5210.749420139158;5232.895342093156;4092.9795351023204;4106.3635136553885;4107.4249605055165;4110.403991421242;4121.196366708493;3943.5662077171487;4125.339945608704;4137.875863724078;4148.3777433385085;4169.394783008548;3794.4308353746883;4046.4941882264716;4054.6350828425434;4087.57080506547;4095.815688294034;4065.3292206785845;4079.5925405734974;4084.326086195774;4085.2850751118435;4091.57038510958;3616.782993020427;3619.6380361963593;3621.3119507293795;3624.438212077106;3630.110622897407;4911.5088491150955;5023.296738456619;5052.267421223902;5066.847994560169;5128.538431541142;4600.4479462464715;4654.325122857201;4667.626589872836;4667.6732628716;4678.134545109166;5407;5417.674939503603;5433.565314774809;5450.836474905759;5451.809186678447;3703.5926048134684;3898.3372826619543;3907.843686252575;3915.295246855565;3975.840966361342;5348.545373643245;5498.615096943176;5527;5611.523020543259;5616.887662246773;3854.190619969838;3866.3233934061427;3866.7873266970023;3872.7095467840027;3967.285888540033;4095.3037983542868;4110.301248787713;4127.782304220263;4139.875803725893;4157.3185295484245;4578.45058592971;4673.719576825401;4678.60231880294;4679.4618618858585;4742.95257047432;5340.626156169031;5412.945870541323;5434.456554344613;5466.890662186734;5468.316460442445;1419.6379923119746;1433.3979728514048;1438.1083728088652;1443.935022923971;1451.4194322271176;898.5417437107122;926.8656044873591;943.8772959515219;945.7421629233104;955.8948515663271;4675.742834144155;4704.553067458654;4746.626686656672;4781.99156354332;4782.736949467743;4903.26451032348;4909.944361962195;4935.383077115361;4936.777844996984;4940.308356830046;4708.987567672967;4712.740799256006;4721.8347357842995;4740.0328863521945;4947.332110165154;2942.4115176964265;2991.6110905582136;3000.5649180869086;3004.422678094018;3006.6241719785025;5781.219535362757;5786.334571524244;5792.304923409133;5799.88400231993;5820.621659592113;5513.117901135799;5699.344575373802;5731.398203188689;5752.698920431777;5754.223179870663;5784.39702134033;5797.913031304533;5807.477327040587;5822.446867547576;5823.621464604787;5387.81142660005;5588.161775733673;5614.971925140511;5654.802081927113;5677.801276955287;5503.257060296809;5538.390777014444;5539.335279766454;5541.141123125922;5564.38791732901;5508.283923089973;5599.32808063035;5600.747966341443;5724.341700704305;5732.398098199629;3933.370660694275;3943.9014024649614;4006.1386801837743;4009.296049179029;4014.177093695727;5682.659040457585;5691.8292451226525;5693.943060569507;5699.458551437607;5710.971445142748;5212;5473.945260547343;5507.449255074621;5513.518916487516;5559.388467268678;5483.506484416422;5494.780208791603;5511.476409741068;5544.1960915667805;5549.611527193058;5382.946170538245;5490.450954904478;5502.119660854244;5573.498385145356;5592.133219351007;5490.450954904478;5514.711394771125;5539.814606601301;5564.499195072301;5604.747786349542;5385.73071346439;5398.1093119634825;5409.729513524387;5438.891222175614;5445.727713614383 01:09:39 INFO - PROCESS | 4185 | |5;yui.html;712.8574285142972;713.7858642407276;722.3426681719635;771.0054030300909;815.2621877201132;16946.661066778674;17614.383496577622;17616.911915440436;17622.647547049084;17654.47036588901;16085.758713619305;16133.515994520154;16181.433649822258;16189.676206475864;16203.756943645854;812.9390295727815;832.7585000349891;832.9708460203894;834.6452757578036;835.6406745099605;671.516508114157;689.427774946793;793.6388943030908;810.0603300171801;818.5784321074622;861.8965724113115;865.645085514939;866.7356456280831;867.7483529776357;867.995660021699;862.2843040276556;864.9135086491364;865.1478293880523;865.1996902864856;865.2818160926479;514.1439503227123;524.9973750131225;608.3703367015162;620.4694985787178;622.3807311724818;14086.788698169536;14209.076410033314;14210.289485525682;14211.21838298893;14233.288335583284;12729;13783.862161378458;13913.373898174606;13961.371738271802;14130.36413361391;12593.93703031488;12964.87035129646;13063;13353.86646133536;13385.464581416732;4352.542982986804;4416.470023597189;4424.358468022118;4468.664850136221;4609.976950115261;81735;83465.58267208686;84540;84912;84940;11061.281016733887;11211.327320360804;11284.097272218203;11360.602378916697;11380.715482112848;21060.47348816292;21099.367018989455;21107.577848442947;21120.366389008355;21126.894365528075;7856.33221176195;8036.236557527026;8098.75703728889;8105.067917189481;8397.193310491255;4583.472900616405;4656;4665.510121437268;4716.575508204278;4824.276358546176;3192.994206824843;3291.654376290503;3467.063892748994;3474.6004209515722;3477.217626034122;586.7418335932176;590.754836742747;594.7442599682179;596.4870211618005;598.5331441475656;576.7202906590301;657.641585335993;670.7417644207015;676.2088356622763;677.915260592426;8175.672973081129;8180.427370084156;8302.460340077876;8774.122587741174;8907.643694252287;660.6927778582982;686.9038334633156;688.4458011300851;706.2831226305304;714.8034290570031;3848.3842585186235;4167.249895018926;4446;4465.910681786346;4499.415076040159;67753.66123169352;78686.21313786904;89004.5549772247;121037;127093;77438.6128069356;102835;103883;103948;107356;74219.25780742231;80262.59868700619;80280.59859700898;81119;82748.17251827405;9042.954785226031;9081;9166.129217724305;9300.348975571645;9485.573149208165;35685.46471802977;41285;46932;48214.00896869864;48486;59133.113003304126;59996;62390.376096240274;68117;68554.65722671355;12974.80537791915;13265.801012985006;13286.867131328563;13360.131591446525;13514.526991555249;15241.6189595261;15257.465988690343;15374.615634609225;15459.458918937784;15669.373225070869;14473.203973781543;14493.92753036228;14720.852791472376;14739.852601474277;14814.185219813015;13441.126326788728;13455.596332110052;13590.796138058135;13857.4457021718;13992.930035349758;13313.467461301827;13451.663708407368;13551.154257606013;13572.660683482993;13581;10631.627893023708;10861.837072444077;11312.434378281218;11352.262102963281;11423.955116990208;9857.408555486694;10479.842802358124;11341.26281791681;11848.644540663794;11902.880971190523 01:09:39 INFO - PROCESS | 4185 | __end_tp_report 01:09:39 INFO - PROCESS | 4185 | __start_cc_report 01:09:39 INFO - PROCESS | 4185 | _x_x_mozilla_cycle_collect,2660 01:09:39 INFO - PROCESS | 4185 | __end_cc_report 01:09:39 INFO - PROCESS | 4185 | __startTimestamp1476950979918__endTimestamp 01:09:39 INFO - PROCESS | 4185 | 01:09:39 INFO - PROCESS | 4185 | ------- Summary: start ------- 01:09:39 INFO - PROCESS | 4185 | Number of tests: 6 01:09:39 INFO - PROCESS | 4185 | 01:09:39 INFO - PROCESS | 4185 | [#0] dojo.html Cycles:165 Average:5389.02 Median:5638.15 stddev:609.92 (10.8%) stddev-sans-first:585.01 01:09:39 INFO - PROCESS | 4185 | Values: 3110.6 3133.3 3161.6 3181.6 3183.4 5332.2 5374.2 5409.9 5450.8 5517.4 5445.2 5445.9 5477.7 5479.1 5495.0 4901.8 4913.7 4940.2 4965.3 4991.4 4871.4 5015.2 5015.7 5052.2 5057.1 5062.0 5070.3 5073.6 5084.5 5132.5 4251.8 4962.7 5059.2 5059.2 5063.3 4817.5 4864.0 4967.2 4986.1 5011.4 5338.3 5367.9 5436.8 5450.5 5521.3 5754.9 5755.0 5758.7 5802.2 5898.6 5876.6 5882.2 5898.2 5898.4 5904.1 5312.4 5343.6 5425.2 5475.0 5481.5 5939.2 5954.1 5970.7 5971.1 6031.9 5738.5 5738.8 5742.6 5747.5 5748.2 5638.2 5680.4 5752.2 5825.2 5828.6 5760.9 5791.6 5857.0 5857.5 5862.2 5795.3 5798.9 5800.2 5801.9 5803.8 4308.5 4370.1 4386.6 4454.4 4454.4 3950.3 3958.4 3959.8 3977.2 4032.6 5521.3 5527.1 5534.0 5538.4 5555.4 5671.5 5824.1 5841.7 5842.6 5850.5 5300.1 5306.0 5340.1 5351.8 5451.7 4917.1 4920.5 4922.2 4922.2 4994.2 5862.6 5868.8 5872.1 5872.5 5878.9 5556.4 5683.3 5767.8 5812.9 5816.5 5986.4 6035.8 6037.2 6037.7 6098.7 5689.8 5727.2 5727.7 5730.0 5731.9 5650.4 5677.8 5708.5 5796.4 5824.4 5662.5 5671.8 5673.1 5676.9 5679.0 5646.0 5650.3 5661.2 5662.6 5663.7 5626.4 5655.9 5661.8 5666.4 5668.4 5689.2 5698.3 5705.7 5732.1 5737.6 5531.7 5532.4 5582.7 5603.0 5608.7 01:09:39 INFO - PROCESS | 4185 | 01:09:39 INFO - PROCESS | 4185 | [#1] ext.html Cycles:180 Average:53956.90 Median:36863.04 stddev:102218.59 (277.3%) stddev-sans-first:102426.76 01:09:39 INFO - PROCESS | 4185 | Values: 572.8 592.6 596.3 603.2 604.6 31637.7 42894.8 44357.0 44360.0 47703.8 44519.8 45132.0 45136.8 45213.5 45220.5 8011.6 8633.4 8814.4 8819.9 8831.6 7694.5 10239.4 10537.1 10546.7 10805.7 10692.8 10753.2 10753.6 10762.1 10764.7 10525.7 10526.9 10583.9 10586.9 10599.5 10388.1 10444.3 10446.9 10461.4 10466.4 41609.4 41859.4 41875.6 41919.0 41934.0 3263.2 3393.3 3724.6 4016.9 4072.5 30809.0 31668.7 31853.2 31865.0 31957.5 4169.9 4248.6 4279.2 4325.4 4348.9 221328.0 224159.0 224177.0 224319.4 224385.0 55854.2 56158.0 56177.2 56261.7 56346.2 58682.4 58742.1 58777.4 58824.7 58871.7 14473.0 14499.2 14508.3 14549.0 14558.4 11431.3 11662.9 12750.7 13119.0 13194.9 15136.8 15532.0 15642.5 15662.3 15721.5 6090.0 6308.2 6314.7 6445.2 6503.5 950.6 1029.4 1037.0 1053.4 1062.4 29764.3 30168.5 30269.5 30639.7 31216.4 1057.3 1079.1 1080.5 1094.6 1124.2 15457.0 16317.9 16362.7 16375.3 16563.8 454237.0 454972.0 455939.0 456961.0 458467.0 56387.0 56660.2 56722.7 56755.4 56792.7 1198.1 1220.5 1226.2 1324.1 1352.4 29948.7 33185.8 33243.7 33382.8 33712.5 52381.5 52997.7 53204.2 53225.2 53298.7 430397.0 434460.0 435490.0 435590.0 436663.0 25694.1 26474.2 26551.2 38731.4 39095.4 38313.2 38485.0 39375.4 43123.8 46328.0 38856.6 40065.4 40134.8 40761.8 41834.4 36732.4 36810.4 36915.6 36952.4 37281.4 39081.4 39146.8 39659.8 40297.4 40501.8 33476.8 35309.6 36227.3 36229.5 36510.5 27020.0 27455.2 27491.5 27499.7 27521.0 01:09:39 INFO - PROCESS | 4185 | 01:09:39 INFO - PROCESS | 4185 | [#2] jquery.html Cycles:180 Average:27606.65 Median:4275.56 stddev:79293.99 (1854.6%) stddev-sans-first:79490.06 01:09:39 INFO - PROCESS | 4185 | Values: 370.9 378.9 385.3 400.9 406.7 14470.9 15118.5 17098.6 19802.7 20234.5 15411.8 17906.3 18292.3 18312.5 19076.2 5592.3 5833.4 5833.6 5837.2 5837.8 5034.9 5727.2 5756.1 5787.0 5787.7 5613.2 5739.4 5756.7 5757.9 5758.0 5476.4 5594.6 5603.4 5614.2 5622.4 4971.0 5002.3 5006.5 5010.1 5012.6 13220.3 13425.6 20729.3 21813.0 22658.8 2225.3 2357.4 2761.3 2775.3 2783.5 9698.7 9723.1 9770.0 10055.4 12057.6 1819.5 1863.2 1872.2 1920.7 1927.2 76019.6 80700.6 82463.6 85101.6 85189.0 9951.7 9961.5 10043.4 10248.8 10374.3 13892.0 13915.7 13918.7 13922.8 13937.2 7610.5 7812.6 7870.0 8013.6 8105.7 7730.6 7737.4 7794.9 7925.7 7979.2 4217.3 4253.2 4297.9 4354.0 4368.9 1854.8 1855.7 1856.5 1883.2 1935.0 424.6 850.9 944.5 989.0 1038.5 10356.2 11168.8 11377.4 11426.4 11487.7 448.6 455.1 473.2 474.0 475.3 5708.1 5723.9 6159.9 6160.3 6191.9 476015.0 478245.0 480762.5 480985.0 483193.0 75340.6 92343.0 92561.0 92943.5 93111.0 453.6 467.4 467.7 469.0 469.0 10359.8 10466.7 10725.9 10732.9 10890.0 40507.6 40877.8 41071.4 42197.4 42511.6 50824.7 51501.7 51535.5 58910.4 62440.7 8109.1 8217.4 8283.7 8426.2 8551.0 9352.5 11115.7 11852.8 11989.6 12510.4 10816.9 10827.6 10853.9 11155.2 11281.3 10368.7 10738.2 11020.3 11059.2 11369.8 10916.9 10955.6 10961.8 11000.7 11277.0 7806.3 7871.9 10817.6 10920.9 11359.3 11299.4 11616.2 12606.4 12692.3 12693.2 01:09:39 INFO - PROCESS | 4185 | 01:09:39 INFO - PROCESS | 4185 | [#3] mootools.html Cycles:180 Average:5735.26 Median:4597.60 stddev:3375.00 (73.4%) stddev-sans-first:3368.40 01:09:39 INFO - PROCESS | 4185 | Values: 1352.8 1448.2 1488.8 1617.3 1762.3 7815.7 8338.1 8648.3 8657.0 8905.4 8719.9 8786.2 8790.8 8797.4 8799.7 2299.0 2326.7 2327.1 2328.5 2330.3 2273.3 2307.6 2325.7 2327.7 2334.8 2264.8 2291.7 2301.4 2315.2 2319.4 2251.5 2259.4 2292.6 2298.2 2301.5 2259.0 2296.7 2296.7 2299.3 2299.5 8898.6 9034.4 9088.6 9089.4 9098.5 5412.3 5556.7 5558.8 5562.8 5564.0 3366.2 3392.7 3429.3 3438.1 3471.4 1061.9 1068.3 1083.2 1095.4 1124.0 12268.2 12354.9 12510.7 12537.6 12550.8 4296.9 4457.4 4579.6 4596.6 4598.6 9767.1 9768.8 9779.2 9780.3 9784.8 5331.9 5334.2 5334.3 5334.7 5335.7 4367.4 4488.7 4797.7 4888.1 4999.7 3730.4 3770.7 3804.9 3845.2 3854.8 1158.5 1178.9 1196.8 1197.9 1201.2 808.6 886.3 902.2 915.4 933.9 5490.8 5519.4 5641.2 5702.0 5707.0 413.2 423.3 426.3 427.2 432.6 3562.7 3710.1 3722.6 3742.3 3848.6 11124.4 11417.7 11448.4 11459.5 11561.5 11070.1 11268.3 11382.2 11387.0 11392.6 8127.3 8304.8 8384.3 8396.2 8399.3 5457.5 5479.2 5488.2 5536.4 5715.2 10062.6 10185.5 10234.6 10269.5 10344.7 10102.8 10362.8 10639.1 10699.8 10707.9 6822.1 7011.3 7225.7 7505.4 7562.2 8281.0 8737.1 8744.2 8745.7 8746.4 7405.3 7463.6 7468.9 7536.8 7828.4 7218.0 7411.5 7532.9 7540.1 7674.9 6493.3 6594.0 6603.7 6632.7 6677.9 4832.6 4840.1 4876.0 4914.7 5118.3 4933.3 4968.2 4989.7 5046.9 5105.5 01:09:39 INFO - PROCESS | 4185 | 01:09:39 INFO - PROCESS | 4185 | [#4] prototype.html Cycles:180 Average:4558.26 Median:5081.63 stddev:1330.55 (26.2%) stddev-sans-first:1295.54 01:09:39 INFO - PROCESS | 4185 | Values: 311.5 321.0 329.1 329.8 331.2 4720.5 4950.9 5220.5 5230.2 5254.7 5096.4 5185.0 5190.7 5210.7 5232.9 4093.0 4106.4 4107.4 4110.4 4121.2 3943.6 4125.3 4137.9 4148.4 4169.4 3794.4 4046.5 4054.6 4087.6 4095.8 4065.3 4079.6 4084.3 4085.3 4091.6 3616.8 3619.6 3621.3 3624.4 3630.1 4911.5 5023.3 5052.3 5066.8 5128.5 4600.4 4654.3 4667.6 4667.7 4678.1 5407.0 5417.7 5433.6 5450.8 5451.8 3703.6 3898.3 3907.8 3915.3 3975.8 5348.5 5498.6 5527.0 5611.5 5616.9 3854.2 3866.3 3866.8 3872.7 3967.3 4095.3 4110.3 4127.8 4139.9 4157.3 4578.5 4673.7 4678.6 4679.5 4743.0 5340.6 5412.9 5434.5 5466.9 5468.3 1419.6 1433.4 1438.1 1443.9 1451.4 898.5 926.9 943.9 945.7 955.9 4675.7 4704.6 4746.6 4782.0 4782.7 4903.3 4909.9 4935.4 4936.8 4940.3 4709.0 4712.7 4721.8 4740.0 4947.3 2942.4 2991.6 3000.6 3004.4 3006.6 5781.2 5786.3 5792.3 5799.9 5820.6 5513.1 5699.3 5731.4 5752.7 5754.2 5784.4 5797.9 5807.5 5822.4 5823.6 5387.8 5588.2 5615.0 5654.8 5677.8 5503.3 5538.4 5539.3 5541.1 5564.4 5508.3 5599.3 5600.7 5724.3 5732.4 3933.4 3943.9 4006.1 4009.3 4014.2 5682.7 5691.8 5693.9 5699.5 5711.0 5212.0 5473.9 5507.4 5513.5 5559.4 5483.5 5494.8 5511.5 5544.2 5549.6 5382.9 5490.5 5502.1 5573.5 5592.1 5490.5 5514.7 5539.8 5564.5 5604.7 5385.7 5398.1 5409.7 5438.9 5445.7 01:09:39 INFO - PROCESS | 4185 | 01:09:39 INFO - PROCESS | 4185 | [#5] yui.html Cycles:180 Average:19890.34 Median:4541.44 stddev:28108.85 (618.9%) stddev-sans-first:28150.81 01:09:39 INFO - PROCESS | 4185 | Values: 712.9 713.8 722.3 771.0 815.3 16946.7 17614.4 17616.9 17622.6 17654.5 16085.8 16133.5 16181.4 16189.7 16203.8 812.9 832.8 833.0 834.6 835.6 671.5 689.4 793.6 810.1 818.6 861.9 865.6 866.7 867.7 868.0 862.3 864.9 865.1 865.2 865.3 514.1 525.0 608.4 620.5 622.4 14086.8 14209.1 14210.3 14211.2 14233.3 12729.0 13783.9 13913.4 13961.4 14130.4 12593.9 12964.9 13063.0 13353.9 13385.5 4352.5 4416.5 4424.4 4468.7 4610.0 81735.0 83465.6 84540.0 84912.0 84940.0 11061.3 11211.3 11284.1 11360.6 11380.7 21060.5 21099.4 21107.6 21120.4 21126.9 7856.3 8036.2 8098.8 8105.1 8397.2 4583.5 4656.0 4665.5 4716.6 4824.3 3193.0 3291.7 3467.1 3474.6 3477.2 586.7 590.8 594.7 596.5 598.5 576.7 657.6 670.7 676.2 677.9 8175.7 8180.4 8302.5 8774.1 8907.6 660.7 686.9 688.4 706.3 714.8 3848.4 4167.2 4446.0 4465.9 4499.4 67753.7 78686.2 89004.6 121037.0 127093.0 77438.6 102835.0 103883.0 103948.0 107356.0 74219.3 80262.6 80280.6 81119.0 82748.2 9043.0 9081.0 9166.1 9300.3 9485.6 35685.5 41285.0 46932.0 48214.0 48486.0 59133.1 59996.0 62390.4 68117.0 68554.7 12974.8 13265.8 13286.9 13360.1 13514.5 15241.6 15257.5 15374.6 15459.5 15669.4 14473.2 14493.9 14720.9 14739.9 14814.2 13441.1 13455.6 13590.8 13857.4 13992.9 13313.5 13451.7 13551.2 13572.7 13581.0 10631.6 10861.8 11312.4 11352.3 11424.0 9857.4 10479.8 11341.3 11848.6 11902.9 01:09:39 INFO - PROCESS | 4185 | -------- Summary: end -------- 01:09:39 INFO - PROCESS | 4185 | 01:09:40 INFO - TEST-INFO | 4185: exit 0 01:09:40 INFO - TEST-OK | dromaeo_css | took 1119438ms 01:09:40 INFO - TEST-START | kraken 01:09:40 INFO - operating with platform_type : linux_ 01:09:40 INFO - Initialising browser for kraken test... 01:09:40 INFO - TEST-INFO | started process 4489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv1AxuR/profile http://localhost:39459/getInfo.html) 01:09:45 INFO - PROCESS | 4489 | __metrics Screen width/height:1600/1200 01:09:45 INFO - PROCESS | 4489 | colorDepth:24 01:09:45 INFO - PROCESS | 4489 | Browser inner width/height: 1024/697 01:09:45 INFO - PROCESS | 4489 | __metrics 01:09:45 INFO - PROCESS | 4489 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:09:45 INFO - PROCESS | 4489 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:09:46 INFO - PROCESS | 4489 | console.error: PushService: 01:09:46 INFO - PROCESS | 4489 | stateChangeProcessEnqueue: Error transitioning state 01:09:46 INFO - PROCESS | 4489 | UnknownError 01:09:47 INFO - TEST-INFO | 4489: exit 0 01:09:47 INFO - Browser initialized. 01:09:47 INFO - Running cycle 1/1 for kraken test... 01:09:47 INFO - TEST-INFO | started process 4574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv1AxuR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:59 INFO - PROCESS | 4574 | RSS: Main: 171876352 01:09:59 INFO - PROCESS | 4574 | 01:10:01 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39459/tests/kraken/driver.html?testName=audio-beat-detection) 01:10:02 INFO - PROCESS | 4574 | RSS: Main: 237838336 01:10:02 INFO - PROCESS | 4574 | 01:10:05 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39459/tests/kraken/driver.html?testName=audio-dft) 01:10:06 INFO - PROCESS | 4574 | RSS: Main: 215851008 01:10:06 INFO - PROCESS | 4574 | 01:10:09 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39459/tests/kraken/driver.html?testName=audio-fft) 01:10:09 INFO - PROCESS | 4574 | RSS: Main: 297611264 01:10:09 INFO - PROCESS | 4574 | 01:10:11 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39459/tests/kraken/driver.html?testName=audio-oscillator) 01:10:12 INFO - PROCESS | 4574 | RSS: Main: 206434304 01:10:12 INFO - PROCESS | 4574 | 01:10:14 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:10:15 INFO - PROCESS | 4574 | RSS: Main: 211869696 01:10:15 INFO - PROCESS | 4574 | 01:10:18 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39459/tests/kraken/driver.html?testName=imaging-darkroom) 01:10:18 INFO - PROCESS | 4574 | RSS: Main: 248471552 01:10:18 INFO - PROCESS | 4574 | 01:10:22 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39459/tests/kraken/driver.html?testName=imaging-desaturate) 01:10:22 INFO - PROCESS | 4574 | RSS: Main: 247287808 01:10:22 INFO - PROCESS | 4574 | 01:10:25 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39459/tests/kraken/driver.html?testName=json-parse-financial) 01:10:25 INFO - PROCESS | 4574 | RSS: Main: 246833152 01:10:25 INFO - PROCESS | 4574 | 01:10:27 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:10:27 INFO - PROCESS | 4574 | RSS: Main: 208936960 01:10:27 INFO - PROCESS | 4574 | 01:10:29 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39459/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:10:30 INFO - PROCESS | 4574 | RSS: Main: 215670784 01:10:30 INFO - PROCESS | 4574 | 01:10:32 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:10:32 INFO - PROCESS | 4574 | RSS: Main: 226172928 01:10:32 INFO - PROCESS | 4574 | 01:10:35 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:10:36 INFO - PROCESS | 4574 | RSS: Main: 233877504 01:10:36 INFO - PROCESS | 4574 | 01:10:39 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:10:39 INFO - PROCESS | 4574 | RSS: Main: 231063552 01:10:39 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:39459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39459/tests/kraken/driver.html?testName=ai-astar) 01:10:41 INFO - PROCESS | 4574 | RSS: Main: 281763840 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | __start_tp_report 01:10:41 INFO - PROCESS | 4574 | _x_x_mozilla_page_load 01:10:41 INFO - PROCESS | 4574 | _x_x_mozilla_page_load_details 01:10:41 INFO - PROCESS | 4574 | |i|pagename|runs| 01:10:41 INFO - PROCESS | 4574 | |0;ai-astar;103;109;111;110;111;111;110;110;109;110 01:10:41 INFO - PROCESS | 4574 | |1;audio-beat-detection;148;125;120;166;128;122;123;121;163;123 01:10:41 INFO - PROCESS | 4574 | |2;audio-dft;162;160;162;163;160;161;162;160;162;162 01:10:41 INFO - PROCESS | 4574 | |3;audio-fft;75;76;77;109;77;76;75;75;109;75 01:10:41 INFO - PROCESS | 4574 | |4;audio-oscillator;83;82;119;82;82;83;108;82;82;116 01:10:41 INFO - PROCESS | 4574 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;117 01:10:41 INFO - PROCESS | 4574 | |6;imaging-darkroom;147;148;147;146;146;147;145;145;145;145 01:10:41 INFO - PROCESS | 4574 | |7;imaging-desaturate;84;85;85;85;84;85;85;84;85;85 01:10:41 INFO - PROCESS | 4574 | |8;json-parse-financial;53;51;52;51;52;55;54;54;55;53 01:10:41 INFO - PROCESS | 4574 | |9;json-stringify-tinderbox;58;60;59;59;60;59;59;59;59;59 01:10:41 INFO - PROCESS | 4574 | |10;stanford-crypto-aes;89;81;88;80;80;88;83;80;85;79 01:10:41 INFO - PROCESS | 4574 | |11;stanford-crypto-ccm;131;135;136;131;132;138;130;141;175;130 01:10:41 INFO - PROCESS | 4574 | |12;stanford-crypto-pbkdf2;167;172;168;169;169;172;171;172;170;167 01:10:41 INFO - PROCESS | 4574 | |13;stanford-crypto-sha256-iterative;67;66;66;65;66;65;65;65;66;65 01:10:41 INFO - PROCESS | 4574 | __end_tp_report 01:10:41 INFO - PROCESS | 4574 | __start_cc_report 01:10:41 INFO - PROCESS | 4574 | _x_x_mozilla_cycle_collect,1696 01:10:41 INFO - PROCESS | 4574 | __end_cc_report 01:10:41 INFO - PROCESS | 4574 | __startTimestamp1476951041695__endTimestamp 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | ------- Summary: start ------- 01:10:41 INFO - PROCESS | 4574 | Number of tests: 14 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.37 (2.2%) stddev-sans-first:0.78 01:10:41 INFO - PROCESS | 4574 | Values: 103.0 109.0 111.0 110.0 111.0 111.0 110.0 110.0 109.0 110.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:126.50 stddev:18.04 (14.3%) stddev-sans-first:18.40 01:10:41 INFO - PROCESS | 4574 | Values: 148.0 125.0 120.0 166.0 128.0 122.0 123.0 121.0 163.0 123.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 01:10:41 INFO - PROCESS | 4574 | Values: 162.0 160.0 162.0 163.0 160.0 161.0 162.0 160.0 162.0 162.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.50 stddev:14.04 (18.6%) stddev-sans-first:14.64 01:10:41 INFO - PROCESS | 4574 | Values: 75.0 76.0 77.0 109.0 77.0 76.0 75.0 75.0 109.0 75.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:82.00 stddev:15.72 (19.2%) stddev-sans-first:16.34 01:10:41 INFO - PROCESS | 4574 | Values: 83.0 82.0 119.0 82.0 82.0 83.0 108.0 82.0 82.0 116.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:10:41 INFO - PROCESS | 4574 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:1.10 (0.8%) stddev-sans-first:1.12 01:10:41 INFO - PROCESS | 4574 | Values: 147.0 148.0 147.0 146.0 146.0 147.0 145.0 145.0 145.0 145.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 01:10:41 INFO - PROCESS | 4574 | Values: 84.0 85.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 85.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.50 stddev:1.49 (2.8%) stddev-sans-first:1.58 01:10:41 INFO - PROCESS | 4574 | Values: 53.0 51.0 52.0 51.0 52.0 55.0 54.0 54.0 55.0 53.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 01:10:41 INFO - PROCESS | 4574 | Values: 58.0 60.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:3.89 (4.6%) stddev-sans-first:3.54 01:10:41 INFO - PROCESS | 4574 | Values: 89.0 81.0 88.0 80.0 80.0 88.0 83.0 80.0 85.0 79.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:135.50 stddev:13.55 (10.0%) stddev-sans-first:14.14 01:10:41 INFO - PROCESS | 4574 | Values: 131.0 135.0 136.0 131.0 132.0 138.0 130.0 141.0 175.0 130.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.50 stddev:2.00 (1.2%) stddev-sans-first:1.87 01:10:41 INFO - PROCESS | 4574 | Values: 167.0 172.0 168.0 169.0 169.0 172.0 171.0 172.0 170.0 167.0 01:10:41 INFO - PROCESS | 4574 | 01:10:41 INFO - PROCESS | 4574 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 01:10:41 INFO - PROCESS | 4574 | Values: 67.0 66.0 66.0 65.0 66.0 65.0 65.0 65.0 66.0 65.0 01:10:41 INFO - PROCESS | 4574 | -------- Summary: end -------- 01:10:41 INFO - PROCESS | 4574 | 01:10:42 INFO - TEST-INFO | 4574: exit 0 01:10:43 INFO - TEST-OK | kraken | took 62098ms 01:10:43 INFO - SUITE-END | took 1181s 01:10:43 INFO - Completed test suite (00:19:41) 01:10:43 INFO - javascript benchmark 01:10:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.626724793025, 3133.263683034485, 3161.557381966524, 3181.570487984123, 3183.3633273345336, 5332.200169974506, 5374.220737992989, 5409.891802163955, 5450.809221677242, 5517.36550296716, 5445.156000819879, 5445.891082178354, 5477.726113694319, 5479.0959491683825, 5495.038368285554, 4901.828436004741, 4913.729744864022, 4940.234263689116, 4965.3048573199785, 4991.425986011601, 4871.439784424783, 5015.197568389059, 5015.724135172564, 5052.242163675442, 5057.115004874132, 5061.974690126544, 5070.264811602316, 5073.644844860862, 5084.491550844923, 5132.5124113209185, 4251.766152861592, 4962.6526143169995, 5059.215821547666, 5059.241113832918, 5063.265826455144, 4817.494163112858, 4864.0, 4967.205247160437, 4986.077575648516, 5011.448740638527, 5338.252644629755, 5367.946320536784, 5436.809711660073, 5450.509454149145, 5521.254630624854, 5754.913676294859, 5754.97122514389, 5758.74085666146, 5802.245708057968, 5898.616589921641, 5876.6180198286975, 5882.2353094097925, 5898.233229680114, 5898.41015898411, 5904.114382842565, 5312.362516498045, 5343.572514198855, 5425.159100339453, 5475.0, 5481.451854814526, 5939.168516407706, 5954.07711804671, 5970.701464926737, 5971.0744834550715, 6031.8793624127275, 5738.483536481736, 5738.8278351649515, 5742.569307301969, 5747.540196784247, 5748.223989761329, 5638.154276858422, 5680.375158732536, 5752.165935939265, 5825.1844741736195, 5828.59199856006, 5760.913586296209, 5791.623544469596, 5857.0335894577765, 5857.47282744555, 5862.179294898718, 5795.333536643256, 5798.94201057984, 5800.158976948319, 5801.9129713054335, 5803.82588522345, 4308.482982042112, 4370.125974805052, 4386.627136693417, 4454.376387305715, 4454.443194600675, 3950.328444164499, 3958.366661334173, 3959.8020098994934, 3977.184677141237, 4032.6169013943627, 5521.282233309644, 5527.060399731975, 5534.0, 5538.418466061005, 5555.416681248492, 5671.546276297886, 5824.068149096124, 5841.7371218295275, 5842.59101862874, 5850.531957443394, 5300.12547929595, 5305.973470132624, 5340.145576707708, 5351.81268655603, 5451.700156491352, 4917.0903382874285, 4920.507949205123, 4922.237053256751, 4922.237053256751, 4994.225894986283, 5862.648241105548, 5868.823935281948, 5872.060470324727, 5872.471477567039, 5878.941210587839, 5556.444355564573, 5683.2895888014, 5767.826965191051, 5812.854678633068, 5816.534677225896, 5986.371430999682, 6035.78874739382, 6037.154798328325, 6037.728302226323, 6098.664573448503, 5689.829305120853, 5727.198192253005, 5727.742251598771, 5729.9713501432225, 5731.8567035824435, 5650.378458369658, 5677.772889084556, 5708.543316534584, 5796.362400135898, 5824.388439213991, 5662.462066103713, 5671.773129074791, 5673.092305231144, 5676.858078547904, 5679.0345641240265, 5646.040173170489, 5650.29371328584, 5661.150827375762, 5662.57530685192, 5663.716814159193, 5626.35296940857, 5655.858603534944, 5661.830145095653, 5666.405027472056, 5668.404817494104, 5689.175069614966, 5698.287714035746, 5705.743241554057, 5732.05421105513, 5737.598368114359, 5531.668099914018, 5532.391436942014, 5582.720863956867, 5603.0, 5608.691521966331], "value": 5348.2668092417725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.7508533787801, 592.5792687192094, 596.3380647481295, 603.2007589943327, 604.5949214026605, 31637.68362316376, 42894.785526072366, 44356.99999999992, 44359.999999999956, 47703.76148119263, 44519.77740111303, 45132.0, 45136.77431612845, 45213.547864521344, 45220.54779452205, 8011.599420029004, 8633.3524985626, 8814.382993190478, 8819.867701984444, 8831.646734130627, 7694.461387702835, 10239.436830974293, 10537.104346130589, 10546.736331591695, 10805.675829725122, 10692.78614427711, 10753.193510486706, 10753.569857205703, 10762.139028877671, 10764.677059688183, 10525.684229473129, 10526.9473652632, 10583.947080264588, 10586.947065264701, 10599.470026498644, 10388.065074143364, 10444.26890117692, 10446.947765261126, 10461.424621645807, 10466.424346660931, 41609.37585936213, 41859.372109418386, 41875.58124418747, 41919.0, 41934.0, 3263.216827961296, 3393.2874096439778, 3724.627537246281, 4016.9196616067516, 4072.450219220397, 30809.0, 31668.733250669946, 31853.203669908205, 31865.0, 31957.52063719046, 4169.854055108087, 4248.575142485757, 4279.1869544786705, 4325.437693099877, 4348.90237743959, 221328.0, 224159.0, 224177.0, 224319.3920151993, 224385.0, 55854.162187566406, 56158.0, 56177.15734263989, 56261.718691406284, 56346.154807677915, 58682.41317586855, 58742.11886821701, 58777.4122258772, 58824.70587647035, 58871.70564147152, 14473.0, 14499.202543859978, 14508.274586270643, 14549.0, 14558.41766329335, 11431.314121152758, 11662.88337116635, 12750.744985100246, 13119.0, 13194.934025330003, 15136.772948405562, 15532.0, 15642.530724078295, 15662.295196715948, 15721.528354149394, 6089.995150800157, 6308.243010838729, 6314.684265786692, 6445.1943507061615, 6503.512236582275, 950.6245033211843, 1029.433811403725, 1037.0148359058774, 1053.4206186597341, 1062.3731998121145, 29764.34578467211, 30168.54747178794, 30269.545956810667, 30639.69360306413, 31216.37567248642, 1057.2546354819833, 1079.1205167788228, 1080.4543705428866, 1094.5567045346647, 1124.1681155944543, 15457.0, 16317.918410408109, 16362.729946657408, 16375.344986200656, 16563.83436165647, 454237.0, 454972.0, 455939.0, 456961.0, 458467.0, 56387.0, 56660.15009774857, 56722.71638641781, 56755.43244567584, 56792.71603642038, 1198.1493139870615, 1220.4934951995178, 1226.1845872494869, 1324.1260767893145, 1352.3576301256824, 29948.70051299459, 33185.83407082949, 33243.66756332406, 33382.83308583441, 33712.49431258582, 52381.47618523766, 52997.735011324694, 53204.20193697175, 53225.20162197648, 53298.733506333774, 430397.0, 434460.0, 435490.0, 435590.0, 436663.0, 25694.100706475183, 26474.205773826816, 26551.203463896112, 38731.41902871403, 39095.41356879706, 38313.233735325695, 38485.0, 39375.40936885892, 43123.784381077894, 46328.0, 38856.6114338853, 40065.399019014156, 40134.79932600318, 40761.79619101885, 41834.372484412146, 36732.44901326536, 36810.447843281836, 36915.63084369122, 36952.44571331486, 37281.44077838889, 39081.413778792776, 39146.804265978484, 39659.80170099131, 40297.395539067526, 40501.79749101236, 33476.83261583676, 35309.646903530636, 36227.27545449129, 36229.456558152175, 36510.4523432154, 27020.0, 27455.17634470969, 27491.450170996868, 27499.725002749718, 27521.0], "value": 19576.656158391863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8739028730231, 378.92915218331814, 385.2545324796519, 400.94587230723846, 406.7051387743886, 14470.927645361759, 15118.546443606681, 17098.5725356866, 19802.70295945562, 20234.494137646547, 15411.845881541181, 17906.283748650072, 18292.268309267612, 18312.542186445346, 19076.23695052196, 5592.328920529532, 5833.358330583633, 5833.562482813806, 5837.24115864937, 5837.824865254049, 5034.892323688782, 5727.169560413738, 5756.079027355603, 5786.9710651446685, 5787.652740835542, 5613.242212301348, 5739.397363276858, 5756.712164391784, 5757.884842303151, 5757.971210143944, 5476.397596264408, 5594.636348637346, 5603.3836278009385, 5614.214010038598, 5622.381538030813, 4970.950290497121, 5002.274670172841, 5006.4743201964, 5010.123228435045, 5012.573931215851, 13220.272884991322, 13425.597232083053, 20729.27447539344, 21813.0184141714, 22658.77341226583, 2225.265662331427, 2357.3635118518077, 2761.278214253629, 2775.34779326858, 2783.5128852450944, 9698.70903872885, 9723.124918757276, 9770.0, 10055.446950417723, 12057.57798477049, 1819.4814477873742, 1863.2174486715612, 1872.1668857358482, 1920.7407000055093, 1927.226951204895, 76019.61990190069, 80700.59649701713, 82463.56887544716, 85101.57449212714, 85189.0, 9951.701448956543, 9961.452120133317, 10043.397396156253, 10248.795024099625, 10374.27380083402, 13892.0, 13915.721685566232, 13918.652033699036, 13922.791158132635, 13937.233452160026, 7610.4672672913475, 7812.648430820626, 7870.0, 8013.639386227634, 8105.716299929592, 7730.613469326511, 7737.381009519225, 7794.921006202631, 7925.682972681028, 7979.162187970295, 4217.325227963511, 4253.234417804763, 4297.892552686208, 4353.956460435355, 4368.934465983013, 1854.7959724430573, 1855.7030875060195, 1856.5358660334916, 1883.227876570627, 1934.951626209356, 424.61572277089283, 850.910654381281, 944.504135328944, 988.980220395588, 1038.4911393417171, 10356.223283253787, 11168.832467512993, 11377.37424441647, 11426.371549564854, 11487.712807179887, 448.6455699996966, 455.14660012476605, 473.18375801742405, 473.9857804265878, 475.28944228378106, 5708.058170401837, 5723.8855222896145, 6159.876802463926, 6160.322364539897, 6191.854506916235, 476015.0, 478245.0, 480762.5389968794, 480985.0, 483193.0, 75340.62329688427, 92343.0, 92561.0, 92943.53528232315, 93111.0, 453.555515594719, 467.43440437071524, 467.7474163951496, 468.96951698139515, 468.9765511724468, 10359.844602331123, 10466.738331541772, 10725.89274107249, 10732.851590843506, 10890.0, 40507.59492405038, 40877.79561102294, 41071.38392924049, 42197.367039495046, 42511.574884252, 50824.74587627038, 51501.7424912873, 51535.48464515307, 58910.41089589049, 62440.68779656073, 8109.107998120084, 8217.424780265324, 8283.710070147516, 8426.241638252586, 8551.0, 9352.53237338144, 11115.72210694739, 11852.76294474123, 11989.64031079069, 12510.437030333474, 10816.891831081903, 10827.646544181976, 10853.891461085288, 11155.163362747664, 11281.32312061279, 10368.740781480523, 10738.248322617343, 11020.283681560673, 11059.22585419013, 11369.772604548029, 10916.890831091587, 10955.616553420592, 10961.83557246626, 11000.724981875517, 11277.0, 7806.336461400844, 7871.881921771293, 10817.593712817283, 10920.890791092304, 11359.318440893572, 11299.43502824839, 11616.16666500036, 12606.432710527864, 12692.301923394301, 12693.238405695687], "value": 8147.273264001362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.8162857499688, 1448.1673038003148, 1488.8064551608288, 1617.2722274976263, 1762.3215062201048, 7815.726449574259, 8338.082810890804, 8648.264897483721, 8657.047724750288, 8905.376623636348, 8719.912800871989, 8786.20924116831, 8790.780230494242, 8797.38418310717, 8799.692010779623, 2299.034405549669, 2326.7324257710325, 2327.0924339507606, 2328.511012687329, 2330.3475026992382, 2273.2839155665997, 2307.561563302967, 2325.697659304288, 2327.697399338092, 2334.8482348647367, 2264.762199969004, 2291.7249930008425, 2301.413139649387, 2315.235972129202, 2319.4085508195385, 2251.538434620899, 2259.367377134405, 2292.5529521743265, 2298.184144628658, 2301.4821665125464, 2259.0, 2296.6784650148993, 2296.70142881426, 2299.344686764281, 2299.494111295512, 8898.644054237822, 9034.412763170372, 9088.636454541811, 9089.409188402733, 9098.545072746403, 5412.269343638637, 5556.749946252428, 5558.77764889408, 5562.833115006556, 5564.0, 3366.208940898887, 3392.7116195123444, 3429.2798512312443, 3438.0889064397707, 3471.427214509603, 1061.930974486656, 1068.3483075324045, 1083.1767856429092, 1095.4030053620795, 1124.0, 12268.202566833128, 12354.876451235463, 12510.687232819162, 12537.623871283877, 12550.81173782394, 4296.91406171881, 4457.442819647544, 4579.633629309647, 4596.6322694185055, 4598.563136502027, 9767.120959113714, 9768.755781105387, 9779.168770654433, 9780.315377923476, 9784.755381115529, 5331.86670333237, 5334.226537152169, 5334.253204551366, 5334.653247538898, 5335.706536140549, 4367.388565600819, 4488.708233964782, 4797.712137271705, 4888.144574699484, 4999.700017998932, 3730.4404339349317, 3770.7171962102952, 3804.923901521954, 3845.2309538092495, 3854.8265328060306, 1158.507634255438, 1178.929264244148, 1196.8085106383112, 1197.898178654824, 1201.159188568006, 808.5754978636263, 886.2688282167109, 902.1970446302664, 915.3546749541557, 933.8785957825439, 5490.752916118784, 5519.365272993577, 5641.153826925994, 5702.0, 5706.971465142731, 413.1736526946108, 423.3163441042694, 426.3455595660646, 427.19686988462115, 432.55662945481134, 3562.697170740516, 3710.1466662667735, 3722.553293604785, 3742.2515496900182, 3848.615138486129, 11124.388158651353, 11417.714557136138, 11448.427578621036, 11459.541618335339, 11561.479733412016, 11070.114390848712, 11268.267562608404, 11382.203245772716, 11387.0, 11392.601258955896, 8127.3091787198755, 8304.792380190424, 8384.329253659693, 8396.160383961555, 8399.28606068491, 5457.508824205841, 5479.178123281539, 5488.17677348401, 5536.446355364431, 5715.199872017838, 10062.597496100074, 10185.49072546355, 10234.6417875374, 10269.53787079598, 10344.741381465523, 10102.78766548019, 10362.844557331495, 10639.14886809069, 10699.839502407314, 10707.89292107069, 6822.11312529368, 7011.298870112948, 7225.674844631899, 7505.362044226302, 7562.2437756223935, 8281.0, 8737.126287371466, 8744.213020828156, 8745.737627871174, 8746.431481953652, 7405.259474052552, 7463.626818659154, 7468.887966680612, 7536.8492630148185, 7828.412869034732, 7218.0, 7411.518251313647, 7532.945387645844, 7540.057492813398, 7674.923250767644, 6493.253275873335, 6593.977933420328, 6603.669816509059, 6632.734690612321, 6677.933220667731, 4832.613390928647, 4840.056189043103, 4876.024795040935, 4914.680545764514, 5118.257852611276, 4933.309336692794, 4968.205087186033, 4989.72556509381, 5046.899062018812, 5105.540501354896], "value": 4463.748293589746, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.5389223948558, 320.99839500802494, 329.0687354785956, 329.7839914855769, 331.23154282065605, 4720.480747117823, 4950.895869255561, 5220.477952204782, 5230.2416149658275, 5254.658447200929, 5096.413912400066, 5185.029688718282, 5190.740462976855, 5210.749420139158, 5232.895342093156, 4092.9795351023204, 4106.3635136553885, 4107.4249605055165, 4110.403991421242, 4121.196366708493, 3943.5662077171487, 4125.339945608704, 4137.875863724078, 4148.3777433385085, 4169.394783008548, 3794.4308353746883, 4046.4941882264716, 4054.6350828425434, 4087.57080506547, 4095.815688294034, 4065.3292206785845, 4079.5925405734974, 4084.326086195774, 4085.2850751118435, 4091.57038510958, 3616.782993020427, 3619.6380361963593, 3621.3119507293795, 3624.438212077106, 3630.110622897407, 4911.5088491150955, 5023.296738456619, 5052.267421223902, 5066.847994560169, 5128.538431541142, 4600.4479462464715, 4654.325122857201, 4667.626589872836, 4667.6732628716, 4678.134545109166, 5407.0, 5417.674939503603, 5433.565314774809, 5450.836474905759, 5451.809186678447, 3703.5926048134684, 3898.3372826619543, 3907.843686252575, 3915.295246855565, 3975.840966361342, 5348.545373643245, 5498.615096943176, 5527.0, 5611.523020543259, 5616.887662246773, 3854.190619969838, 3866.3233934061427, 3866.7873266970023, 3872.7095467840027, 3967.285888540033, 4095.3037983542868, 4110.301248787713, 4127.782304220263, 4139.875803725893, 4157.3185295484245, 4578.45058592971, 4673.719576825401, 4678.60231880294, 4679.4618618858585, 4742.95257047432, 5340.626156169031, 5412.945870541323, 5434.456554344613, 5466.890662186734, 5468.316460442445, 1419.6379923119746, 1433.3979728514048, 1438.1083728088652, 1443.935022923971, 1451.4194322271176, 898.5417437107122, 926.8656044873591, 943.8772959515219, 945.7421629233104, 955.8948515663271, 4675.742834144155, 4704.553067458654, 4746.626686656672, 4781.99156354332, 4782.736949467743, 4903.26451032348, 4909.944361962195, 4935.383077115361, 4936.777844996984, 4940.308356830046, 4708.987567672967, 4712.740799256006, 4721.8347357842995, 4740.0328863521945, 4947.332110165154, 2942.4115176964265, 2991.6110905582136, 3000.5649180869086, 3004.422678094018, 3006.6241719785025, 5781.219535362757, 5786.334571524244, 5792.304923409133, 5799.88400231993, 5820.621659592113, 5513.117901135799, 5699.344575373802, 5731.398203188689, 5752.698920431777, 5754.223179870663, 5784.39702134033, 5797.913031304533, 5807.477327040587, 5822.446867547576, 5823.621464604787, 5387.81142660005, 5588.161775733673, 5614.971925140511, 5654.802081927113, 5677.801276955287, 5503.257060296809, 5538.390777014444, 5539.335279766454, 5541.141123125922, 5564.38791732901, 5508.283923089973, 5599.32808063035, 5600.747966341443, 5724.341700704305, 5732.398098199629, 3933.370660694275, 3943.9014024649614, 4006.1386801837743, 4009.296049179029, 4014.177093695727, 5682.659040457585, 5691.8292451226525, 5693.943060569507, 5699.458551437607, 5710.971445142748, 5212.0, 5473.945260547343, 5507.449255074621, 5513.518916487516, 5559.388467268678, 5483.506484416422, 5494.780208791603, 5511.476409741068, 5544.1960915667805, 5549.611527193058, 5382.946170538245, 5490.450954904478, 5502.119660854244, 5573.498385145356, 5592.133219351007, 5490.450954904478, 5514.711394771125, 5539.814606601301, 5564.499195072301, 5604.747786349542, 5385.73071346439, 5398.1093119634825, 5409.729513524387, 5438.891222175614, 5445.727713614383], "value": 4137.583931324328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.8574285142972, 713.7858642407276, 722.3426681719635, 771.0054030300909, 815.2621877201132, 16946.661066778674, 17614.383496577622, 17616.911915440436, 17622.647547049084, 17654.47036588901, 16085.758713619305, 16133.515994520154, 16181.433649822258, 16189.676206475864, 16203.756943645854, 812.9390295727815, 832.7585000349891, 832.9708460203894, 834.6452757578036, 835.6406745099605, 671.516508114157, 689.427774946793, 793.6388943030908, 810.0603300171801, 818.5784321074622, 861.8965724113115, 865.645085514939, 866.7356456280831, 867.7483529776357, 867.995660021699, 862.2843040276556, 864.9135086491364, 865.1478293880523, 865.1996902864856, 865.2818160926479, 514.1439503227123, 524.9973750131225, 608.3703367015162, 620.4694985787178, 622.3807311724818, 14086.788698169536, 14209.076410033314, 14210.289485525682, 14211.21838298893, 14233.288335583284, 12729.0, 13783.862161378458, 13913.373898174606, 13961.371738271802, 14130.36413361391, 12593.93703031488, 12964.87035129646, 13063.0, 13353.86646133536, 13385.464581416732, 4352.542982986804, 4416.470023597189, 4424.358468022118, 4468.664850136221, 4609.976950115261, 81735.0, 83465.58267208686, 84540.0, 84912.0, 84940.0, 11061.281016733887, 11211.327320360804, 11284.097272218203, 11360.602378916697, 11380.715482112848, 21060.47348816292, 21099.367018989455, 21107.577848442947, 21120.366389008355, 21126.894365528075, 7856.33221176195, 8036.236557527026, 8098.75703728889, 8105.067917189481, 8397.193310491255, 4583.472900616405, 4656.0, 4665.510121437268, 4716.575508204278, 4824.276358546176, 3192.994206824843, 3291.654376290503, 3467.063892748994, 3474.6004209515722, 3477.217626034122, 586.7418335932176, 590.754836742747, 594.7442599682179, 596.4870211618005, 598.5331441475656, 576.7202906590301, 657.641585335993, 670.7417644207015, 676.2088356622763, 677.915260592426, 8175.672973081129, 8180.427370084156, 8302.460340077876, 8774.122587741174, 8907.643694252287, 660.6927778582982, 686.9038334633156, 688.4458011300851, 706.2831226305304, 714.8034290570031, 3848.3842585186235, 4167.249895018926, 4446.0, 4465.910681786346, 4499.415076040159, 67753.66123169352, 78686.21313786904, 89004.5549772247, 121037.0, 127093.0, 77438.6128069356, 102835.0, 103883.0, 103948.0, 107356.0, 74219.25780742231, 80262.59868700619, 80280.59859700898, 81119.0, 82748.17251827405, 9042.954785226031, 9081.0, 9166.129217724305, 9300.348975571645, 9485.573149208165, 35685.46471802977, 41285.0, 46932.0, 48214.00896869864, 48486.0, 59133.113003304126, 59996.0, 62390.376096240274, 68117.0, 68554.65722671355, 12974.80537791915, 13265.801012985006, 13286.867131328563, 13360.131591446525, 13514.526991555249, 15241.6189595261, 15257.465988690343, 15374.615634609225, 15459.458918937784, 15669.373225070869, 14473.203973781543, 14493.92753036228, 14720.852791472376, 14739.852601474277, 14814.185219813015, 13441.126326788728, 13455.596332110052, 13590.796138058135, 13857.4457021718, 13992.930035349758, 13313.467461301827, 13451.663708407368, 13551.154257606013, 13572.660683482993, 13581.0, 10631.627893023708, 10861.837072444077, 11312.434378281218, 11352.262102963281, 11423.955116990208, 9857.408555486694, 10479.842802358124, 11341.26281791681, 11848.644540663794, 11902.880971190523], "value": 7423.299621547931, "unit": "score"}], "name": "dromaeo_css", "value": 6993.190601347223, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 111.0, 110.0, 111.0, 111.0, 110.0, 110.0, 109.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 120.0, 166.0, 128.0, 122.0, 123.0, 121.0, 163.0, 123.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 163.0, 160.0, 161.0, 162.0, 160.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 109.0, 77.0, 76.0, 75.0, 75.0, 109.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 119.0, 82.0, 82.0, 83.0, 108.0, 82.0, 82.0, 116.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 52.0, 55.0, 54.0, 54.0, 55.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 88.0, 80.0, 80.0, 88.0, 83.0, 80.0, 85.0, 79.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 135.0, 136.0, 131.0, 132.0, 138.0, 130.0, 141.0, 175.0, 130.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 168.0, 169.0, 169.0, 172.0, 171.0, 172.0, 170.0, 167.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1495.5, "alertThreshold": 2.0}]} 01:10:43 INFO - Return code: 0 01:10:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:10:43 INFO - # TBPL SUCCESS # 01:10:43 INFO - Running post-action listener: _resource_record_post_action 01:10:43 INFO - [mozharness: 2016-10-20 08:10:43.504170Z] Finished run-tests step (success) 01:10:43 INFO - Running post-run listener: _resource_record_post_run 01:10:43 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391733248; Read time: 12; Write time: 266564 01:10:43 INFO - TinderboxPrint: CPU usage
13.1% 01:10:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:10:43 INFO - TinderboxPrint: I/O write bytes / time
391,733,248 / 266,564 01:10:43 INFO - TinderboxPrint: CPU idle
8,314.6 (86.9%) 01:10:43 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 01:10:43 INFO - TinderboxPrint: Swap in / out
0 / 0 01:10:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103624704; Read time: 0; Write time: 74144 01:10:43 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288108544; Read time: 0; Write time: 192420 01:10:44 INFO - Running post-run listener: _upload_blobber_files 01:10:44 INFO - Blob upload gear active. 01:10:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:10:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:10:44 INFO - (blobuploader) - INFO - Open directory for files ... 01:10:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:10:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:10:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:45 INFO - (blobuploader) - INFO - Done attempting. 01:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:10:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:48 INFO - (blobuploader) - INFO - Done attempting. 01:10:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:10:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:10:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:10:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:10:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:10:49 INFO - (blobuploader) - INFO - Done attempting. 01:10:49 INFO - (blobuploader) - INFO - Iteration through files over. 01:10:49 INFO - Return code: 0 01:10:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:10:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:10:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/641a6635c69d228477241486ed19e6c96c2a8af766401ec10572eff02d755f6ec3582f20eba47190194a4dc094e56a917fed26603c61b317e8b95fc2ac998b28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f4a5452a056221d1b73eecea2d093864323b61cdbce42c6d753c0b7cbb49a32e435805ed03d427a03c9c210145709787d087d1d489548e4315326915608956", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0043f4efcbe5fe2531abef3b708a1afea4e3913251f33391870508a12e975308fdeb4445ca3e5ac8b1e167ec5e53f24ebace04213794e241554a2a82c39b8e27"} 01:10:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:10:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:10:49 INFO - Contents: 01:10:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/641a6635c69d228477241486ed19e6c96c2a8af766401ec10572eff02d755f6ec3582f20eba47190194a4dc094e56a917fed26603c61b317e8b95fc2ac998b28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f4a5452a056221d1b73eecea2d093864323b61cdbce42c6d753c0b7cbb49a32e435805ed03d427a03c9c210145709787d087d1d489548e4315326915608956", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0043f4efcbe5fe2531abef3b708a1afea4e3913251f33391870508a12e975308fdeb4445ca3e5ac8b1e167ec5e53f24ebace04213794e241554a2a82c39b8e27"} 01:10:49 INFO - Running post-run listener: copy_logs_to_upload_dir 01:10:49 INFO - Copying logs to upload dir... 01:10:49 INFO - mkdir: /builds/slave/test/build/upload/logs 01:10:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.403843 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-20 01:10:49.505725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 01:10:49.513634) ========= 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-1476946743.898202-1939430651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/641a6635c69d228477241486ed19e6c96c2a8af766401ec10572eff02d755f6ec3582f20eba47190194a4dc094e56a917fed26603c61b317e8b95fc2ac998b28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f4a5452a056221d1b73eecea2d093864323b61cdbce42c6d753c0b7cbb49a32e435805ed03d427a03c9c210145709787d087d1d489548e4315326915608956", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0043f4efcbe5fe2531abef3b708a1afea4e3913251f33391870508a12e975308fdeb4445ca3e5ac8b1e167ec5e53f24ebace04213794e241554a2a82c39b8e27"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476937808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/641a6635c69d228477241486ed19e6c96c2a8af766401ec10572eff02d755f6ec3582f20eba47190194a4dc094e56a917fed26603c61b317e8b95fc2ac998b28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f4a5452a056221d1b73eecea2d093864323b61cdbce42c6d753c0b7cbb49a32e435805ed03d427a03c9c210145709787d087d1d489548e4315326915608956", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0043f4efcbe5fe2531abef3b708a1afea4e3913251f33391870508a12e975308fdeb4445ca3e5ac8b1e167ec5e53f24ebace04213794e241554a2a82c39b8e27"}' ========= master_lag: 0.63 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 01:10:50.159237) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 01:10:50.159639) ========= 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-1476946743.898202-1939430651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.20 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 01:10:50.360037) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 01:10:50.360425) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 01:10:50.371313) ========= ========= Total master_lag: 1.08 =========