builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1477143093.51 results: success (0) buildid: 20161022062847 builduid: 57fd192b8a4b47df8864c02b51e676ce revision: e5ad3002313cd67f83d67d49db1315d6ba05fa87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:33.511994) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:33.512427) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:33.512728) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:33.528011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:33.528338) ========= 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=6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-22 06:31:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.0M=0s 2016-10-22 06:31:34 (33.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149313 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:33.776316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:33.776619) ========= 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=6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016212 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:33.805036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 06:31:33.805386) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e5ad3002313cd67f83d67d49db1315d6ba05fa87 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e5ad3002313cd67f83d67d49db1315d6ba05fa87 --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=6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-22 06:31:35,150 truncating revision to first 12 chars 2016-10-22 06:31:35,150 Setting DEBUG logging. 2016-10-22 06:31:35,150 attempt 1/10 2016-10-22 06:31:35,150 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e5ad3002313c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-22 06:31:36,444 unpacking tar archive at: mozilla-inbound-e5ad3002313c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.634007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 06:31:35.452773) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:35.453111) ========= script_repo_revision: e5ad3002313cd67f83d67d49db1315d6ba05fa87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:35.453500) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:35.453758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 06:31:35.463554) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-22 06:31:35.463866) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:31:36 INFO - MultiFileLogger online at 20161022 06:31:36 in /builds/slave/test 06:31:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 06:31:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:31:36 INFO - {'append_to_log': False, 06:31:36 INFO - 'base_work_dir': '/builds/slave/test', 06:31:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:31:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:31:36 INFO - 'branch': 'Mozilla-Inbound', 06:31:36 INFO - 'buildbot_json_path': 'buildprops.json', 06:31:36 INFO - 'config_files': ('talos/linux_config.py',), 06:31:36 INFO - 'default_actions': ('clobber', 06:31:36 INFO - 'read-buildbot-config', 06:31:36 INFO - 'download-and-extract', 06:31:36 INFO - 'populate-webroot', 06:31:36 INFO - 'create-virtualenv', 06:31:36 INFO - 'install', 06:31:36 INFO - 'run-tests'), 06:31:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:31:36 INFO - 'download_minidump_stackwalk': True, 06:31:36 INFO - 'download_symbols': 'ondemand', 06:31:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:31:36 INFO - 'tooltool.py': '/tools/tooltool.py', 06:31:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:31:36 INFO - '/tools/misc-python/virtualenv.py')}, 06:31:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:31:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:31:36 INFO - 'installer_path': 'installer.exe', 06:31:36 INFO - 'log_level': 'info', 06:31:36 INFO - 'log_name': 'talos', 06:31:36 INFO - 'log_to_console': True, 06:31:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:31:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:31:36 INFO - 'opt_config_files': (), 06:31:36 INFO - 'pip_index': False, 06:31:36 INFO - 'sps_profile': False, 06:31:36 INFO - 'sps_profile_interval': 0, 06:31:36 INFO - 'suite': 'dromaeojs', 06:31:36 INFO - 'system_bits': '32', 06:31:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:31:36 INFO - 'title': 'talos-linux64-ix-050', 06:31:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:31:36 INFO - 'use_talos_json': True, 06:31:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:31:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:31:36 INFO - 'work_dir': 'build'} 06:31:36 INFO - [mozharness: 2016-10-22 13:31:36.907984Z] Running clobber step. 06:31:36 INFO - Running pre-action listener: _resource_record_pre_action 06:31:36 INFO - Running main action method: clobber 06:31:36 INFO - rmtree: /builds/slave/test/build 06:31:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:31:37 INFO - Running post-action listener: _resource_record_post_action 06:31:37 INFO - [mozharness: 2016-10-22 13:31:37.372716Z] Finished clobber step (success) 06:31:37 INFO - [mozharness: 2016-10-22 13:31:37.372816Z] Running read-buildbot-config step. 06:31:37 INFO - Running pre-action listener: _resource_record_pre_action 06:31:37 INFO - Running main action method: read_buildbot_config 06:31:37 INFO - Using buildbot properties: 06:31:37 INFO - { 06:31:37 INFO - "project": "", 06:31:37 INFO - "product": "firefox", 06:31:37 INFO - "script_repo_revision": "production", 06:31:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:31:37 INFO - "repository": "", 06:31:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:31:37 INFO - "buildid": "20161022062847", 06:31:37 INFO - "stage_platform": "linux64-pgo", 06:31:37 INFO - "basedir": "/builds/slave/test", 06:31:37 INFO - "buildnumber": 2621, 06:31:37 INFO - "platform": "ubuntu64_hw", 06:31:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:31:37 INFO - "slavebuilddir": "test", 06:31:37 INFO - "branch": "mozilla-inbound", 06:31:37 INFO - "revision": "e5ad3002313cd67f83d67d49db1315d6ba05fa87", 06:31:37 INFO - "slavename": "talos-linux64-ix-050", 06:31:37 INFO - "builduid": "57fd192b8a4b47df8864c02b51e676ce", 06:31:37 INFO - "repo_path": "integration/mozilla-inbound" 06:31:37 INFO - } 06:31:37 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:31:37 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 06:31:37 INFO - Running post-action listener: _resource_record_post_action 06:31:37 INFO - [mozharness: 2016-10-22 13:31:37.375555Z] Finished read-buildbot-config step (success) 06:31:37 INFO - [mozharness: 2016-10-22 13:31:37.375643Z] Running download-and-extract step. 06:31:37 INFO - Running pre-action listener: _resource_record_pre_action 06:31:37 INFO - Running main action method: download_and_extract 06:31:37 INFO - mkdir: /builds/slave/test/build/tests 06:31:37 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')]} 06:31:37 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:31:37 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/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 06:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/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 06:31:37 INFO - Downloaded 1361 bytes. 06:31:37 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:31:37 INFO - Using the following test package requirements: 06:31:37 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:31:37 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:31:37 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:31:37 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:37 INFO - u'jsshell-linux-x86_64.zip'], 06:31:37 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:31:37 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:31:37 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:31:37 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:31:37 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:31:37 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:31:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:31:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:31:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:31:37 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:31:37 INFO - Http code: 200 06:31:37 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 06:31:37 INFO - x-amz-cf-id: BFEvqjr8WNDkUQxWvCSlwP9wNq8-ZA6jogsFBgnDgbmPI7HxE7t4DA== 06:31:37 INFO - x-amz-replication-status: COMPLETED 06:31:37 INFO - x-amz-version-id: aSP.FZ53pFo3A0bM2gmPyVs05I63i6ez 06:31:37 INFO - Expected file size: 22032937 06:31:37 INFO - Obtained file size: 22032937 06:31:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:31:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:31:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:31:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:31:41 INFO - Http code: 200 06:31:41 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 06:31:41 INFO - x-amz-cf-id: H3ELaB9bOQJhuKwhiGP-LDZxFhvm9n8EgWa37sOI-zhfEBr_HmMUlA== 06:31:41 INFO - x-amz-replication-status: COMPLETED 06:31:41 INFO - x-amz-version-id: aSP.FZ53pFo3A0bM2gmPyVs05I63i6ez 06:31:42 INFO - Expected file size: 22032937 06:31:42 INFO - Obtained file size: 22032937 06:31:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:31:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:31:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:31:46 INFO - Http code: 200 06:31:46 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 06:31:46 INFO - x-amz-cf-id: UlP75l_6yXKX_UC7BOu1VTYQ3TLLeO2_x3kg31-a1BXfD0_uTjCyGw== 06:31:46 INFO - x-amz-replication-status: COMPLETED 06:31:46 INFO - x-amz-version-id: HX37d.wkZVjdAiWSnJt_ZAG.uCKhrPOJ 06:31:46 INFO - Expected file size: 14409028 06:31:46 INFO - Obtained file size: 14409028 06:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:47 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:31:47 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/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 06:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/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 06:31:47 INFO - Downloaded 59346196 bytes. 06:31:47 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:31:47 INFO - mkdir: /builds/slave/test/properties 06:31:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:31:47 INFO - Writing to file /builds/slave/test/properties/build_url 06:31:47 INFO - Contents: 06:31:47 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:31:47 INFO - Running post-action listener: _resource_record_post_action 06:31:47 INFO - Running post-action listener: set_extra_try_arguments 06:31:47 INFO - [mozharness: 2016-10-22 13:31:47.925643Z] Finished download-and-extract step (success) 06:31:47 INFO - [mozharness: 2016-10-22 13:31:47.925869Z] Running populate-webroot step. 06:31:47 INFO - Running pre-action listener: _resource_record_pre_action 06:31:47 INFO - Running main action method: populate_webroot 06:31:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:31:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:31:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:31:47 INFO - '--tppagecycles', 06:31:47 INFO - '7'], 06:31:47 INFO - 'tests': ['tsvgm']}}, 06:31:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:31:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:31:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:31:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:31:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:47 INFO - 'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:47 INFO - 'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['damp', 'tps']}, 06:31:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:47 INFO - 'tests': ['damp', 'tps']}, 06:31:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['dromaeo_dom']}, 06:31:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:31:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['basic_compositor_video']}, 06:31:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:31:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['a11yr', 06:31:47 INFO - 'ts_paint', 06:31:47 INFO - 'tpaint', 06:31:47 INFO - 'sessionrestore', 06:31:47 INFO - 'sessionrestore_no_auto_restore', 06:31:47 INFO - 'tabpaint']}, 06:31:47 INFO - 'other-e10s': {'tests': ['a11yr', 06:31:47 INFO - 'ts_paint', 06:31:47 INFO - 'tpaint', 06:31:47 INFO - 'sessionrestore', 06:31:47 INFO - 'sessionrestore_no_auto_restore', 06:31:47 INFO - 'tabpaint']}, 06:31:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:31:47 INFO - 'ts_paint', 06:31:47 INFO - 'tpaint', 06:31:47 INFO - 'sessionrestore', 06:31:47 INFO - 'sessionrestore_no_auto_restore', 06:31:47 INFO - 'tabpaint']}, 06:31:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:31:47 INFO - 'ts_paint', 06:31:47 INFO - 'tpaint', 06:31:47 INFO - 'sessionrestore', 06:31:47 INFO - 'sessionrestore_no_auto_restore', 06:31:47 INFO - 'tabpaint']}, 06:31:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['a11yr', 06:31:47 INFO - 'ts_paint', 06:31:47 INFO - 'tpaint', 06:31:47 INFO - 'sessionrestore', 06:31:47 INFO - 'sessionrestore_no_auto_restore', 06:31:47 INFO - 'tabpaint']}, 06:31:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['a11yr', 06:31:47 INFO - 'ts_paint', 06:31:47 INFO - 'tpaint', 06:31:47 INFO - 'sessionrestore', 06:31:47 INFO - 'sessionrestore_no_auto_restore', 06:31:47 INFO - 'tabpaint']}, 06:31:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['tsvgx', 06:31:47 INFO - 'tsvgr_opacity', 06:31:47 INFO - 'tart', 06:31:47 INFO - 'tscrollx', 06:31:47 INFO - 'cart']}, 06:31:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:31:47 INFO - 'tsvgr_opacity', 06:31:47 INFO - 'tart', 06:31:47 INFO - 'tscrollx', 06:31:47 INFO - 'cart']}, 06:31:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:47 INFO - 'talos_options': ['--disable-e10s'], 06:31:47 INFO - 'tests': ['tp5o']}, 06:31:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:47 INFO - 'tests': ['tp5o']}, 06:31:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:47 INFO - 'talos_options': ['--disable-e10s', 06:31:47 INFO - '--xperf_path', 06:31:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:47 INFO - 'tests': ['tp5n']}, 06:31:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:47 INFO - 'talos_options': ['--xperf_path', 06:31:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:47 INFO - 'tests': ['tp5n']}}, 06:31:47 INFO - 'talos.zip': {'path': '', 06:31:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:31:47 INFO - Running post-action listener: _resource_record_post_action 06:31:47 INFO - [mozharness: 2016-10-22 13:31:47.943672Z] Finished populate-webroot step (success) 06:31:47 INFO - [mozharness: 2016-10-22 13:31:47.943760Z] Running create-virtualenv step. 06:31:47 INFO - Running pre-action listener: _resource_record_pre_action 06:31:47 INFO - Running main action method: create_virtualenv 06:31:47 INFO - Creating virtualenv /builds/slave/test/build/venv 06:31:47 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 06:31:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:31:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:31:48 INFO - Using real prefix '/usr' 06:31:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:31:48 INFO - Installing distribute.............................................................................................................................................................................................done. 06:31:50 INFO - Installing pip.................done. 06:31:50 INFO - Return code: 0 06:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:31:50 INFO - Reading from file tmpfile_stdout 06:31:50 INFO - Output received: 06:31:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:31:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:31:50 INFO - Using env: {'DISPLAY': ':0', 06:31:50 INFO - 'HOME': '/home/cltbld', 06:31:50 INFO - 'LANG': 'en_US.UTF-8', 06:31:50 INFO - 'LANGUAGE': 'en_US:en', 06:31:50 INFO - 'LOGNAME': 'cltbld', 06:31:50 INFO - 'MAIL': '/var/mail/cltbld', 06:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:50 INFO - 'MOZ_NO_REMOTE': '1', 06:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:50 INFO - 'NO_EM_RESTART': '1', 06:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:50 INFO - 'PWD': '/builds/slave/test', 06:31:50 INFO - 'SHELL': '/bin/bash', 06:31:50 INFO - 'SHLVL': '1', 06:31:50 INFO - 'TERM': 'linux', 06:31:50 INFO - 'TMOUT': '86400', 06:31:50 INFO - 'USER': 'cltbld', 06:31:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:50 INFO - '_': '/tools/buildbot/bin/python'} 06:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:50 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 06:31:50 INFO - Cleaning up... 06:31:50 INFO - Return code: 0 06:31:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:31:51 INFO - Using env: {'DISPLAY': ':0', 06:31:51 INFO - 'HOME': '/home/cltbld', 06:31:51 INFO - 'LANG': 'en_US.UTF-8', 06:31:51 INFO - 'LANGUAGE': 'en_US:en', 06:31:51 INFO - 'LOGNAME': 'cltbld', 06:31:51 INFO - 'MAIL': '/var/mail/cltbld', 06:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:51 INFO - 'MOZ_NO_REMOTE': '1', 06:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:51 INFO - 'NO_EM_RESTART': '1', 06:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:51 INFO - 'PWD': '/builds/slave/test', 06:31:51 INFO - 'SHELL': '/bin/bash', 06:31:51 INFO - 'SHLVL': '1', 06:31:51 INFO - 'TERM': 'linux', 06:31:51 INFO - 'TMOUT': '86400', 06:31:51 INFO - 'USER': 'cltbld', 06:31:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:51 INFO - '_': '/tools/buildbot/bin/python'} 06:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:51 INFO - Downloading/unpacking psutil>=3.1.1 06:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:31:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:53 INFO - Installing collected packages: psutil 06:31:53 INFO - Running setup.py install for psutil 06:31:53 INFO - building 'psutil._psutil_linux' extension 06:31:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:31:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:31:53 INFO - building 'psutil._psutil_posix' extension 06:31:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:31:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:31:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:53 INFO - Successfully installed psutil 06:31:53 INFO - Cleaning up... 06:31:53 INFO - Return code: 0 06:31:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:31:53 INFO - Using env: {'DISPLAY': ':0', 06:31:53 INFO - 'HOME': '/home/cltbld', 06:31:53 INFO - 'LANG': 'en_US.UTF-8', 06:31:53 INFO - 'LANGUAGE': 'en_US:en', 06:31:53 INFO - 'LOGNAME': 'cltbld', 06:31:53 INFO - 'MAIL': '/var/mail/cltbld', 06:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:53 INFO - 'MOZ_NO_REMOTE': '1', 06:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:53 INFO - 'NO_EM_RESTART': '1', 06:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:53 INFO - 'PWD': '/builds/slave/test', 06:31:53 INFO - 'SHELL': '/bin/bash', 06:31:53 INFO - 'SHLVL': '1', 06:31:53 INFO - 'TERM': 'linux', 06:31:53 INFO - 'TMOUT': '86400', 06:31:53 INFO - 'USER': 'cltbld', 06:31:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:53 INFO - '_': '/tools/buildbot/bin/python'} 06:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:31:55 INFO - Installing collected packages: mozsystemmonitor 06:31:55 INFO - Running setup.py install for mozsystemmonitor 06:31:56 INFO - Successfully installed mozsystemmonitor 06:31:56 INFO - Cleaning up... 06:31:56 INFO - Return code: 0 06:31:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:31:56 INFO - Using env: {'DISPLAY': ':0', 06:31:56 INFO - 'HOME': '/home/cltbld', 06:31:56 INFO - 'LANG': 'en_US.UTF-8', 06:31:56 INFO - 'LANGUAGE': 'en_US:en', 06:31:56 INFO - 'LOGNAME': 'cltbld', 06:31:56 INFO - 'MAIL': '/var/mail/cltbld', 06:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:56 INFO - 'MOZ_NO_REMOTE': '1', 06:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:56 INFO - 'NO_EM_RESTART': '1', 06:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:56 INFO - 'PWD': '/builds/slave/test', 06:31:56 INFO - 'SHELL': '/bin/bash', 06:31:56 INFO - 'SHLVL': '1', 06:31:56 INFO - 'TERM': 'linux', 06:31:56 INFO - 'TMOUT': '86400', 06:31:56 INFO - 'USER': 'cltbld', 06:31:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:56 INFO - '_': '/tools/buildbot/bin/python'} 06:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:56 INFO - Downloading/unpacking jsonschema==2.5.1 06:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:31:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:58 INFO - Downloading functools32-3.2.3-2.tar.gz 06:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:31:58 INFO - warning: no files found matching '*.txt' 06:31:58 INFO - no previously-included directories found matching 'build' 06:31:58 INFO - no previously-included directories found matching 'dist' 06:31:58 INFO - no previously-included directories found matching '.git*' 06:31:58 INFO - Installing collected packages: jsonschema, functools32 06:31:58 INFO - Running setup.py install for functools32 06:31:58 INFO - warning: no files found matching '*.txt' 06:31:58 INFO - no previously-included directories found matching 'build' 06:31:58 INFO - no previously-included directories found matching 'dist' 06:31:58 INFO - no previously-included directories found matching '.git*' 06:31:58 INFO - Successfully installed jsonschema functools32 06:31:58 INFO - Cleaning up... 06:31:58 INFO - Return code: 0 06:31:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:31:58 INFO - Using env: {'DISPLAY': ':0', 06:31:58 INFO - 'HOME': '/home/cltbld', 06:31:58 INFO - 'LANG': 'en_US.UTF-8', 06:31:58 INFO - 'LANGUAGE': 'en_US:en', 06:31:58 INFO - 'LOGNAME': 'cltbld', 06:31:58 INFO - 'MAIL': '/var/mail/cltbld', 06:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:58 INFO - 'MOZ_NO_REMOTE': '1', 06:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:58 INFO - 'NO_EM_RESTART': '1', 06:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:58 INFO - 'PWD': '/builds/slave/test', 06:31:58 INFO - 'SHELL': '/bin/bash', 06:31:58 INFO - 'SHLVL': '1', 06:31:58 INFO - 'TERM': 'linux', 06:31:58 INFO - 'TMOUT': '86400', 06:31:58 INFO - 'USER': 'cltbld', 06:31:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:58 INFO - '_': '/tools/buildbot/bin/python'} 06:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:31:58 INFO - Cleaning up... 06:31:58 INFO - Return code: 0 06:31:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:31:58 INFO - Using env: {'DISPLAY': ':0', 06:31:58 INFO - 'HOME': '/home/cltbld', 06:31:58 INFO - 'LANG': 'en_US.UTF-8', 06:31:58 INFO - 'LANGUAGE': 'en_US:en', 06:31:58 INFO - 'LOGNAME': 'cltbld', 06:31:58 INFO - 'MAIL': '/var/mail/cltbld', 06:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:58 INFO - 'MOZ_NO_REMOTE': '1', 06:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:58 INFO - 'NO_EM_RESTART': '1', 06:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:58 INFO - 'PWD': '/builds/slave/test', 06:31:58 INFO - 'SHELL': '/bin/bash', 06:31:58 INFO - 'SHLVL': '1', 06:31:58 INFO - 'TERM': 'linux', 06:31:58 INFO - 'TMOUT': '86400', 06:31:58 INFO - 'USER': 'cltbld', 06:31:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:58 INFO - '_': '/tools/buildbot/bin/python'} 06:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:59 INFO - Downloading/unpacking blobuploader==1.2.4 06:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:01 INFO - Downloading blobuploader-1.2.4.tar.gz 06:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:32:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:32:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:01 INFO - Downloading docopt-0.6.1.tar.gz 06:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:32:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:32:01 INFO - Running setup.py install for blobuploader 06:32:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:32:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:32:01 INFO - Running setup.py install for requests 06:32:02 INFO - Running setup.py install for docopt 06:32:02 INFO - Successfully installed blobuploader requests docopt 06:32:02 INFO - Cleaning up... 06:32:02 INFO - Return code: 0 06:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:32:02 INFO - Using env: {'DISPLAY': ':0', 06:32:02 INFO - 'HOME': '/home/cltbld', 06:32:02 INFO - 'LANG': 'en_US.UTF-8', 06:32:02 INFO - 'LANGUAGE': 'en_US:en', 06:32:02 INFO - 'LOGNAME': 'cltbld', 06:32:02 INFO - 'MAIL': '/var/mail/cltbld', 06:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:02 INFO - 'MOZ_NO_REMOTE': '1', 06:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:02 INFO - 'NO_EM_RESTART': '1', 06:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:02 INFO - 'PWD': '/builds/slave/test', 06:32:02 INFO - 'SHELL': '/bin/bash', 06:32:02 INFO - 'SHLVL': '1', 06:32:02 INFO - 'TERM': 'linux', 06:32:02 INFO - 'TMOUT': '86400', 06:32:02 INFO - 'USER': 'cltbld', 06:32:02 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:02 INFO - '_': '/tools/buildbot/bin/python'} 06:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:32:02 INFO - Running setup.py (path:/tmp/pip-HkZB8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:32:02 INFO - Running setup.py (path:/tmp/pip-uttzU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:32:02 INFO - Running setup.py (path:/tmp/pip-1rLxm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:32:02 INFO - Running setup.py (path:/tmp/pip-7UgJst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:32:03 INFO - Running setup.py (path:/tmp/pip-aKSY1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:32:03 INFO - Running setup.py (path:/tmp/pip-SFOees-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:32:03 INFO - Running setup.py (path:/tmp/pip-wsdoil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:32:03 INFO - Running setup.py (path:/tmp/pip-On8hel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:32:03 INFO - Running setup.py (path:/tmp/pip-UON_Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:32:03 INFO - Running setup.py (path:/tmp/pip-wGjeF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:32:03 INFO - Running setup.py (path:/tmp/pip-oCxJvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:32:03 INFO - Running setup.py (path:/tmp/pip-__kFcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:32:03 INFO - Running setup.py (path:/tmp/pip-u5vWgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:32:03 INFO - Running setup.py (path:/tmp/pip-7ped6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:03 INFO - Running setup.py (path:/tmp/pip-4thu_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:32:03 INFO - Running setup.py (path:/tmp/pip-vYCKHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:32:03 INFO - Running setup.py (path:/tmp/pip-Jj_Xsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:32:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:32:03 INFO - Running setup.py install for manifestparser 06:32:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Running setup.py install for mozcrash 06:32:04 INFO - Running setup.py install for mozdebug 06:32:04 INFO - Running setup.py install for mozdevice 06:32:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Running setup.py install for mozfile 06:32:04 INFO - Running setup.py install for mozhttpd 06:32:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Running setup.py install for mozinfo 06:32:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Running setup.py install for mozInstall 06:32:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Running setup.py install for mozleak 06:32:04 INFO - Running setup.py install for mozlog 06:32:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:32:04 INFO - Running setup.py install for moznetwork 06:32:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Running setup.py install for mozprocess 06:32:05 INFO - Running setup.py install for mozprofile 06:32:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Running setup.py install for mozrunner 06:32:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Running setup.py install for mozscreenshot 06:32:05 INFO - Running setup.py install for moztest 06:32:05 INFO - Running setup.py install for mozversion 06:32:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:32:05 INFO - Cleaning up... 06:32:05 INFO - Return code: 0 06:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:32:05 INFO - Using env: {'DISPLAY': ':0', 06:32:05 INFO - 'HOME': '/home/cltbld', 06:32:05 INFO - 'LANG': 'en_US.UTF-8', 06:32:05 INFO - 'LANGUAGE': 'en_US:en', 06:32:05 INFO - 'LOGNAME': 'cltbld', 06:32:05 INFO - 'MAIL': '/var/mail/cltbld', 06:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:05 INFO - 'MOZ_NO_REMOTE': '1', 06:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:05 INFO - 'NO_EM_RESTART': '1', 06:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:05 INFO - 'PWD': '/builds/slave/test', 06:32:05 INFO - 'SHELL': '/bin/bash', 06:32:05 INFO - 'SHLVL': '1', 06:32:05 INFO - 'TERM': 'linux', 06:32:05 INFO - 'TMOUT': '86400', 06:32:05 INFO - 'USER': 'cltbld', 06:32:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:05 INFO - '_': '/tools/buildbot/bin/python'} 06:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:32:05 INFO - Running setup.py (path:/tmp/pip-FXmA1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:32:06 INFO - Running setup.py (path:/tmp/pip-PTB5t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:32:06 INFO - Running setup.py (path:/tmp/pip-eKFcq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:32:06 INFO - Running setup.py (path:/tmp/pip-S0WUAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:32:06 INFO - Running setup.py (path:/tmp/pip-OK1yOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:32:06 INFO - Running setup.py (path:/tmp/pip-kCci8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:32:06 INFO - Running setup.py (path:/tmp/pip-bBtTgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:32:06 INFO - Running setup.py (path:/tmp/pip-r1yggU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:32:06 INFO - Running setup.py (path:/tmp/pip-25STJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:32:06 INFO - Running setup.py (path:/tmp/pip-7DAqKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:32:06 INFO - Running setup.py (path:/tmp/pip-1uvDKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:32:06 INFO - Running setup.py (path:/tmp/pip-A_kBCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:32:06 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)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:32:06 INFO - Running setup.py (path:/tmp/pip-pTzLVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:32:06 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)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:32:06 INFO - Running setup.py (path:/tmp/pip-rchxtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:32:06 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)) 06:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:06 INFO - Running setup.py (path:/tmp/pip-uCzuR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:32:07 INFO - Running setup.py (path:/tmp/pip-jcQ2aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:32:07 INFO - Running setup.py (path:/tmp/pip-fyAifr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:32:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:09 INFO - Downloading blessings-1.6.tar.gz 06:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:32:09 INFO - Installing collected packages: blessings 06:32:09 INFO - Running setup.py install for blessings 06:32:09 INFO - Successfully installed blessings 06:32:09 INFO - Cleaning up... 06:32:09 INFO - Return code: 0 06:32:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:32:09 INFO - Reading from file tmpfile_stdout 06:32:09 INFO - Current package versions: 06:32:09 INFO - argparse == 1.2.1 06:32:09 INFO - blessings == 1.6 06:32:09 INFO - blobuploader == 1.2.4 06:32:09 INFO - docopt == 0.6.1 06:32:09 INFO - functools32 == 3.2.3-2 06:32:09 INFO - jsonschema == 2.5.1 06:32:09 INFO - manifestparser == 1.1 06:32:09 INFO - mozInstall == 1.12 06:32:09 INFO - mozcrash == 0.17 06:32:09 INFO - mozdebug == 0.1 06:32:09 INFO - mozdevice == 0.48 06:32:09 INFO - mozfile == 1.2 06:32:09 INFO - mozhttpd == 0.7 06:32:09 INFO - mozinfo == 0.9 06:32:09 INFO - mozleak == 0.1 06:32:09 INFO - mozlog == 3.4 06:32:09 INFO - moznetwork == 0.27 06:32:09 INFO - mozprocess == 0.23 06:32:09 INFO - mozprofile == 0.28 06:32:09 INFO - mozrunner == 6.12 06:32:09 INFO - mozscreenshot == 0.1 06:32:09 INFO - mozsystemmonitor == 0.3 06:32:09 INFO - moztest == 0.7 06:32:09 INFO - mozversion == 1.4 06:32:09 INFO - psutil == 3.1.1 06:32:09 INFO - requests == 1.2.3 06:32:09 INFO - wsgiref == 0.1.2 06:32:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:32:09 INFO - Using env: {'DISPLAY': ':0', 06:32:09 INFO - 'HOME': '/home/cltbld', 06:32:09 INFO - 'LANG': 'en_US.UTF-8', 06:32:09 INFO - 'LANGUAGE': 'en_US:en', 06:32:09 INFO - 'LOGNAME': 'cltbld', 06:32:09 INFO - 'MAIL': '/var/mail/cltbld', 06:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:09 INFO - 'MOZ_NO_REMOTE': '1', 06:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:09 INFO - 'NO_EM_RESTART': '1', 06:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:09 INFO - 'PWD': '/builds/slave/test', 06:32:09 INFO - 'SHELL': '/bin/bash', 06:32:09 INFO - 'SHLVL': '1', 06:32:09 INFO - 'TERM': 'linux', 06:32:09 INFO - 'TMOUT': '86400', 06:32:09 INFO - 'USER': 'cltbld', 06:32:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:09 INFO - '_': '/tools/buildbot/bin/python'} 06:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:32:09 INFO - Cleaning up... 06:32:09 INFO - Return code: 0 06:32:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff927e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', '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 06:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:32:09 INFO - Using env: {'DISPLAY': ':0', 06:32:09 INFO - 'HOME': '/home/cltbld', 06:32:09 INFO - 'LANG': 'en_US.UTF-8', 06:32:09 INFO - 'LANGUAGE': 'en_US:en', 06:32:09 INFO - 'LOGNAME': 'cltbld', 06:32:09 INFO - 'MAIL': '/var/mail/cltbld', 06:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:09 INFO - 'MOZ_NO_REMOTE': '1', 06:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:09 INFO - 'NO_EM_RESTART': '1', 06:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:09 INFO - 'PWD': '/builds/slave/test', 06:32:09 INFO - 'SHELL': '/bin/bash', 06:32:09 INFO - 'SHLVL': '1', 06:32:09 INFO - 'TERM': 'linux', 06:32:09 INFO - 'TMOUT': '86400', 06:32:09 INFO - 'USER': 'cltbld', 06:32:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:09 INFO - '_': '/tools/buildbot/bin/python'} 06:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:32:10 INFO - Cleaning up... 06:32:10 INFO - Return code: 0 06:32:10 INFO - Running post-action listener: _resource_record_post_action 06:32:10 INFO - Running post-action listener: _start_resource_monitoring 06:32:10 INFO - Starting resource monitoring. 06:32:10 INFO - [mozharness: 2016-10-22 13:32:10.090013Z] Finished create-virtualenv step (success) 06:32:10 INFO - [mozharness: 2016-10-22 13:32:10.090513Z] Running install step. 06:32:10 INFO - Running pre-action listener: _resource_record_pre_action 06:32:10 INFO - Running main action method: install 06:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:32:10 INFO - Reading from file tmpfile_stdout 06:32:10 INFO - Detecting whether we're running mozinstall >=1.0... 06:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:32:10 INFO - Reading from file tmpfile_stdout 06:32:10 INFO - Output received: 06:32:10 INFO - Usage: mozinstall [options] installer 06:32:10 INFO - Options: 06:32:10 INFO - -h, --help show this help message and exit 06:32:10 INFO - -d DEST, --destination=DEST 06:32:10 INFO - Directory to install application into. [default: 06:32:10 INFO - "/builds/slave/test"] 06:32:10 INFO - --app=APP Application being installed. [default: firefox] 06:32:10 INFO - mkdir: /builds/slave/test/build/application 06:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:32:27 INFO - Reading from file tmpfile_stdout 06:32:27 INFO - Output received: 06:32:27 INFO - /builds/slave/test/build/application/firefox/firefox 06:32:27 INFO - Running post-action listener: _resource_record_post_action 06:32:27 INFO - [mozharness: 2016-10-22 13:32:27.300802Z] Finished install step (success) 06:32:27 INFO - [mozharness: 2016-10-22 13:32:27.301154Z] Running run-tests step. 06:32:27 INFO - Running pre-action listener: _resource_record_pre_action 06:32:27 INFO - Running main action method: run_tests 06:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:32:27 INFO - Python 2.7.3 06:32:27 INFO - Return code: 0 06:32:27 INFO - grabbing minidump binary from tooltool 06:32: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')]} 06:32:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8af60>, '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 0xf8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:32:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:32:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:32:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:32:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:32:27 INFO - Return code: 0 06:32:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:32:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:32:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:32:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:32:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 06:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 06:32:27 INFO - Using env: {'DISPLAY': ':0', 06:32:27 INFO - 'HOME': '/home/cltbld', 06:32:27 INFO - 'LANG': 'en_US.UTF-8', 06:32:27 INFO - 'LANGUAGE': 'en_US:en', 06:32:27 INFO - 'LOGNAME': 'cltbld', 06:32:27 INFO - 'MAIL': '/var/mail/cltbld', 06:32:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:32:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:27 INFO - 'MOZ_NO_REMOTE': '1', 06:32:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:27 INFO - 'NO_EM_RESTART': '1', 06:32:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:27 INFO - 'PWD': '/builds/slave/test', 06:32:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:32:27 INFO - 'SHELL': '/bin/bash', 06:32:27 INFO - 'SHLVL': '1', 06:32:27 INFO - 'TERM': 'linux', 06:32:27 INFO - 'TMOUT': '86400', 06:32:27 INFO - 'USER': 'cltbld', 06:32:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233', 06:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:27 INFO - '_': '/tools/buildbot/bin/python'} 06:32:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 06:32:27 INFO - mozversion application_buildid: 20161022033001 06:32:27 INFO - mozversion application_changeset: e5ad3002313cd67f83d67d49db1315d6ba05fa87 06:32:27 INFO - mozversion application_display_name: Nightly 06:32:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:32:27 INFO - mozversion application_name: Firefox 06:32:27 INFO - mozversion application_remotingname: firefox 06:32:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:32:27 INFO - mozversion application_vendor: Mozilla 06:32:27 INFO - mozversion application_version: 52.0a1 06:32:27 INFO - mozversion platform_buildid: 20161022033001 06:32:27 INFO - mozversion platform_changeset: e5ad3002313cd67f83d67d49db1315d6ba05fa87 06:32:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:32:27 INFO - mozversion platform_version: 52.0a1 06:32:27 INFO - using testdate: 1477143147 06:32:27 INFO - actual date: 1477143147 06:32:27 INFO - starting webserver on 'localhost:57948' 06:32:27 INFO - SUITE-START | Running 2 tests 06:32:27 INFO - TEST-START | dromaeo_css 06:32:27 INFO - operating with platform_type : linux_ 06:32:27 INFO - Initialising browser for dromaeo_css test... 06:32:27 INFO - TEST-INFO | started process 3071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt4SI0V/profile http://localhost:57948/getInfo.html) 06:32:31 INFO - PROCESS | 3071 | __metrics Screen width/height:1600/1200 06:32:31 INFO - PROCESS | 3071 | colorDepth:24 06:32:31 INFO - PROCESS | 3071 | Browser inner width/height: 1024/697 06:32:31 INFO - PROCESS | 3071 | __metrics 06:32:32 INFO - PROCESS | 3071 | 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" 06:32:32 INFO - PROCESS | 3071 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:32:32 INFO - PROCESS | 3071 | console.error: PushService: 06:32:32 INFO - PROCESS | 3071 | stateChangeProcessEnqueue: Error transitioning state 06:32:32 INFO - PROCESS | 3071 | UnknownError 06:32:33 INFO - TEST-INFO | 3071: exit 0 06:32:33 INFO - Browser initialized. 06:32:33 INFO - Running cycle 1/1 for dromaeo_css test... 06:32:33 INFO - TEST-INFO | started process 3154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt4SI0V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:45 INFO - PROCESS | 3154 | RSS: Main: 172367872 06:32:45 INFO - PROCESS | 3154 | 06:33:37 INFO - PROCESS | 3154 | 1477143217263 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] 06:35:47 INFO - PROCESS | 3154 | Cycle 1(1): loaded http://localhost:57948/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57948/tests/dromaeo/cssquery-ext.html) 06:35:50 INFO - PROCESS | 3154 | RSS: Main: 437989376 06:35:50 INFO - PROCESS | 3154 | 06:38:53 INFO - PROCESS | 3154 | Cycle 1(1): loaded http://localhost:57948/tests/dromaeo/cssquery-ext.html (next: http://localhost:57948/tests/dromaeo/cssquery-jquery.html) 06:38:54 INFO - PROCESS | 3154 | RSS: Main: 290205696 06:38:54 INFO - PROCESS | 3154 | 06:41:56 INFO - PROCESS | 3154 | Cycle 1(1): loaded http://localhost:57948/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57948/tests/dromaeo/cssquery-mootools.html) 06:41:56 INFO - PROCESS | 3154 | RSS: Main: 261447680 06:41:56 INFO - PROCESS | 3154 | 06:44:58 INFO - PROCESS | 3154 | Cycle 1(1): loaded http://localhost:57948/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57948/tests/dromaeo/cssquery-prototype.html) 06:44:59 INFO - PROCESS | 3154 | RSS: Main: 216776704 06:44:59 INFO - PROCESS | 3154 | 06:48:02 INFO - PROCESS | 3154 | Cycle 1(1): loaded http://localhost:57948/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57948/tests/dromaeo/cssquery-yui.html) 06:48:02 INFO - PROCESS | 3154 | RSS: Main: 221618176 06:48:02 INFO - PROCESS | 3154 | 06:51:05 INFO - PROCESS | 3154 | Cycle 1(1): loaded http://localhost:57948/tests/dromaeo/cssquery-yui.html (next: http://localhost:57948/tests/dromaeo/cssquery-dojo.html) 06:51:05 INFO - PROCESS | 3154 | RSS: Main: 310861824 06:51:05 INFO - PROCESS | 3154 | 06:51:05 INFO - PROCESS | 3154 | __start_tp_report 06:51:05 INFO - PROCESS | 3154 | _x_x_mozilla_page_load 06:51:05 INFO - PROCESS | 3154 | _x_x_mozilla_page_load_details 06:51:05 INFO - PROCESS | 3154 | |i|pagename|runs| 06:51:05 INFO - PROCESS | 3154 | |0;dojo.html;3064.2645765016405;3064.800787948783;3102.1934297082767;3113.3928883867643;3114.7663925205616;5320.893582128355;5335.573154147669;5387.757550910209;5417.45825417458;5440.510354068133;5416.702081385522;5448.945510544893;5499.560035197184;5521.779128834842;5541.196526503654;4864.221724524077;4901.53435423636;4953.9504604953845;4961.330220420251;4978.402591688984;4894.657373983805;5038;5061.316722242487;5062.291279220912;5124.103281925667;4803.663743537953;4947.529984651488;4961.627877909171;5014.473480284572;5074.416442109149;4823.228283474662;4827.08285425768;4831.541003604652;4838.395200599925;4899.436564795059;4784.545468180518;4786;4790.760461976887;4809.470958194595;4850.902981940377;5257.342832145981;5270.156774916033;5280.894382112375;5283.049051170788;5283.365996080456;5619.915701264485;5621.634593751393;5650.773969041234;5720.742566584514;5728.656280623176;5754.884902301972;5794.333651630074;5813.505852002585;5817.883642327172;5885.058390657474;5402.054640437907;5412.648177868466;5413.404525502192;5414.133738601844;5414.269073675004;5725.570582206351;5914.497267732205;5915.674637894871;5928.67392293428;5933.2880054393745;5530.446955304518;5582.302212223472;5586.329640443173;5606.887862242732;5684.289463817023;5638.830835074954;5644.6330988485615;5646.745896434671;5648.406917273709;5717.428257174332;5704.486596206279;5706.172604972256;5709.05800542914;5712.200291959129;5774.220480235199;5529.391766905637;5572.164175373727;5576.1356989666665;5658.490735833712;5725.083986562214;4414.073044660593;4439.223135951195;4444.400005999149;4455.04216593434;4459.888502787457;3957.881263562098;3959.089409435788;3961.485006949136;3988.641022308006;4003.039270575099;5326.786928522815;5381.838544843661;5509.752061157177;5511.834644960658;5516.365617953987;5759.539236861041;5788.942110578841;5809.09958956354;5823.505002074871;5904.1734157218025;5414.864628384243;5479.835604931858;5482.643628164156;5487.5884308677005;5488.067028605146;4930.926036109461;5006.724630145377;5024.145984245714;5025.522575355409;5079.212722028092;5942.64344139353;6048.002079656895;6095.238095238095;6100.938990610214;6118.13190915367;5838.532917366516;5838.649681019152;5846.766129354778;5863.384344643751;5917.6745279010065;6019.367966363468;6091.573589848668;6094.055421409688;6099.359567245376;6101.267847858286;5425.701586412785;5455.672659640434;5464.590155738415;5551.555875529867;5551.7779288828;5626.549876009991;5633.6619802811965;5635.605507614591;5638.210650509014;5644.463775941279;5500.5874559409;5506.449355064461;5507.173923911445;5507.7246137692155;5508.944910551004;5453;5476.041692703681;5483.217954164833;5489.984352894728;5494.752736126804;5462.617616766788;5465.289512363526;5467.6719396836315;5471.863203419787;5488.1767734838495;5674.319081710221;5686.346070201815;5700.714964251853;5705.058665320175;5705.857353566194;5480.506754391964;5594.552435805207;5594.804181853616;5596.048671725735;5600.215969764155 06:51:05 INFO - PROCESS | 3154 | |1;ext.html;559.846042338357;593.7565598104775;624.0670198053907;635.9745610175593;642.8842808294505;32443.837780811093;42735.57264427355;43898.78050609751;43938;47289.76355118228;44107;44476;44555.33167002498;44591.77704111483;44628.77685611568;8752.868706969384;8952.194302512773;8971.95514022429;8972.147645973622;8993.370464067519;7996.08045074818;8227.259546640802;10485.528151233175;10740.301880377789;10748.516316765725;10860.61987830426;10940.23418360715;10941.671749847477;10946.56213751449;10954.39750813705;8100.513969161811;10736.141108711285;10806.243562950596;10812.135029197685;10820.296680715806;7997.320227780646;10197.796044079078;10563.26057175998;10570.15438764897;10863.782724345549;41277.174456511;41384;41565.1686966259;41624.37563436551;41639.1672166558;3386.8306584670913;3438.707709844666;3605.1167463971233;3735.794531300777;3927.6857851372106;31309.217269568217;31475;31566;32662.346753065045;33098.3380332392;3893.552241492236;3976.5029371328583;4015.859444919414;4041.7574945503366;4193.224253513079;318896;319843;321114;322013;322656;58035;58574.70712646495;58631.120533192036;58633.120503192484;58635.12047319294;35931.82034089865;37052.258954820754;37142.62857371392;61116;61314.65678849427;16521.33914643401;16572.75140872888;16575.41986030483;16655.6668866622;16681.499555013368;11635.88364116365;12164.635060948185;12201.694957625952;12210.57262995791;12218.266903985612;16381.754273685905;18273;18844.90577547131;18946.810531894782;19241.51896202578;6807.727690892309;6830;6950.79147625572;7021.419076271139;7087.645617719093;905.2622112977901;983.3215081593678;1014.3305418423805;1061.1086687182803;1094.0864378244096;32209.194770130467;32226.516602250984;32344.35311293761;32654.346913061607;32788;1057.3867157048894;1076.1390887290293;1078.5901357484263;1132.4847194526471;1156.3813359852438;15933.521994340188;17030.74453883193;17061.232244548777;17076.914615426842;17113.401030964105;486994;489581;490206;490439;491689;56425.43574564284;56863;57015.714921425126;57015.714921425955;57071.14393284104;1257.9748405031849;1262.671705356614;1296.5138073222543;1300.5188080410119;1317.3215793866166;29631.555526667547;31056.534151987285;31279;31417.37165256728;31806.52290215695;49339;49944.50055499398;49962.25056624226;49976.50023499864;50002.49997500124;379173;379556;379860;381846;383602;27482.862585686944;27686.723132768413;28058;28059.579106313013;28065.57901631518;46729.76635116803;47295.763521182176;47746;47982.520174797806;48839.755801222185;38370.2325953485;40147;40465.79767101146;40882;41619.58380416157;40904.38643420291;41268.587314127675;41364.537724080976;41404.1719165621;41470.58529414667;39762.40356394598;40453;40573.55124814424;41735.16529669329;42015;33890.49164262587;36324.455133172494;36818.631813682594;37078.629213707514;37253.25493490169;28049.859750701933;28107.773118693432;28241.550695825048;28348.100570378385;28518.42963140767 06:51:05 INFO - PROCESS | 3154 | |2;jquery.html;351.04515717249075;373.1994871001701;376.6610050954143;380.76012112369204;390.79287977371985;14173.362198701057;17760.289588416465;18292.45122646321;18900.716489252638;20149.798502014975;14746.705065898675;17565.29738810446;18622.068896555185;19543.609127817435;19717.408477745656;5494.80768173114;5716.77132914685;5742.253507044099;5762.711864406784;5786.594938354317;4184.456020717303;4289.356596510533;4397.296432570789;5668.858278543028;5764.682942438164;4434.002349471375;6540.182477190351;6546.214454265495;6549.607023578576;6568.014797780347;6199.504039676837;6351.428371446592;6399.968000160016;6530.2163740351225;6535.738570457176;5593.916091258634;5595.048841696921;5596.944030559724;5603.579731520153;5604.243427137325;21804.89097554518;22827.54344913109;22882.542349152925;22947.08211671531;23027.963741631665;2403.218953840009;2533.6698233427414;2585.301968468522;2754.834709917411;3002.0993701889347;13927.512537061255;14486;14516.927415362961;14807.555773326818;15164.24178791056;1835.8990255535941;1900.47536668666;1905.8284754372035;1910.4459706685045;1992.1035534009754;78166.6091669538;78262;78629;79092.60453697752;80319.19680803176;9136.680216192533;9277.304202184863;9573.18627916621;10014.198864090855;10209.846852297222;13204.075714699879;13425.932870335586;13467.663308417172;13472.12431191989;13491.460341586228;7767.572783496962;7866.567338796307;7883.881741773878;8141.307988821017;8142.796430089176;7775.805604859924;7892.210778922176;8007.319377852831;8076.313513351313;8151.429399941947;6152.477039451607;6167.722452489649;6243.687815609202;6269.62382257066;6380.298167201604;1684.1915880377487;1705.8976461412108;1719.3982106262958;1745.7817772778403;1770.5131088950384;924.995375023134;925.167349385545;983.1986930651497;988.8318985772436;1037.699067270483;19117.90441047786;19390.806091939183;19497.317593884145;19526.31657891967;19776.60446791085;988.8912219655832;1008.6570566007592;1025.1593693171528;1071.5499490214129;1094.9452527373758;10322.12261957727;11104.000639942444;11228.831567526493;11335.43322833855;11357.375344355974;422981;429354;430144;432032;434375;44503;47599.762001189774;50401.49598504041;53563.99999999922;75416;990.4552496127101;996.3175224970918;1024.3341827811983;1034.8758149022165;1043.7912417516375;16908.830911691217;16931.238094286033;17751.378701745893;17839.10804459798;18088.547786305448;35719.28561428809;35839.28321433609;36517.26965460729;36942.445863311536;36983.6301636991;48501.27248091211;49254.26118608296;50047.249291259934;51313.48686513087;51626.74186629043;7842.882356764767;7901.288884000468;7925.762227133196;8191.221833925768;8397.664093436195;12111.81832272499;12150.21023633461;12282.32447215376;12637.052221083639;13000.08999370035;10599.523021464207;10885.292455990335;11137.331760094421;11299.887001129884;11703.29780213156;10786.460676966277;11103.888961110608;11327.376994265394;11358.318500889973;11468.541258349906;10581.31221470602;10631.149508039493;10666.89333106659;11074;11137.554497819996;7859.724909628136;7909.446338756462;8048.1147073823;8078.232567906274;8085.070216925129;10531.473426328806;10903.12774977984;10976.231663783778;10986.176036797113;11019.559217631206 06:51:05 INFO - PROCESS | 3154 | |3;mootools.html;1455.323274677275;1490.9030912990654;1587.6824635072987;1757.376131473326;1788.4098247578293;7499.850002999937;7706.6917323307;8637.179467950551;9307.81384372313;9313.81372372553;8768.736937891857;9048.864267035984;9081.545922703855;9311.58097885595;9322.580483878224;2341.063574570173;2370.751071137523;2375.809935205188;2376.2158487699016;2378.63131214662;2033.6949457581406;2083.6145313117045;2345.636426353918;2363.2201373546773;2388.3312672451652;2302.643090321003;2355.3169580821627;2363.3737059679197;2368.1829768729845;2381.226101517014;2370.2889133260123;2374.03851440167;2377.037299893546;2378.6907701998803;2385.809135269183;2313.5257272259146;2323.5352929414184;2327.569399661068;2329.592321343775;2367.9644805327935;9070.18368346852;9119.49842758648;9183.44899306037;9209;9214.585343659484;5256.789728410859;5441.075017247077;5471.425500322449;5534.667919924777;5552.833414997556;3279.147421670359;3447.258839349552;3452.1369657585606;3464.34177506273;3506.7019303359243;1057.4237040812775;1102.3000394749313;1110.8889111088906;1122.5902545570807;1129.2829053551054;13269.668258293523;13307.733845323039;13324.333783310893;13326.267055311953;13341.19952802835;4420.381146639473;4605.677602567788;4761;4800.183968725325;4845.273209018605;10788.298760580537;10799.460026998775;10804.243702940876;10806.675799726021;10809.135269178447;5355.812546560852;5368;5368.946310536845;5369.838904832861;5372.70450125239;4791.544803243686;4848.8302909398;4872.9512704873205;4880.658353915192;4888.682235654671;3712.832922518493;3723.106454450912;3779.527559055118;3825.6365645263654;3899.629535194152;1061.395004847245;1095.638439315024;1245.8255844181822;1276.7957126859844;1287.7251520994148;915.2769312243387;928.535732133933;939.9718008459757;942.3649967306717;956.364017928084;5752.424757524214;5779.104238842986;5854.268216472941;6087.05650624154;6114.296855861633;930.5858892792643;943.1417410156724;945.5697657565792;964.4984608003799;967.9951600241953;3866.709996750255;3982.3628219484744;3996.500437445319;4015.6586690131667;4029.1135950090934;11331.263467874562;11792.056635469142;11830;11860.644180674593;11863.228890122115;11566.42167891602;11617.709557260967;11620.244684095507;11654.067674586013;11678.007369373698;8036.718714844952;8324.542150181676;8348.165183481604;8483.787905302417;8581.141885811368;5576.525995290283;5720.914186287126;5805;5825.563082768894;5926.081457374114;10044.296899216984;10466.424346661006;10496.52765625564;10568.20738444635;10648.307859989076;10555.525001374803;10718.517666704862;10801.135909127408;10888.020078193;10907.618233361794;8168.632411541376;8225.876611850947;8236.299914507093;8288.792780180544;8291;8804.383693141419;8865.867011994955;8937.642494300155;9012.369134160546;9013.053629368822;6214.8135555933395;7905.6837726492595;8020.719274825353;8039.879401809095;8333.250007499355;7883.684652614061;8009.279164875189;8050.718224862102;8069.677212911418;8078.555679437687;6934.133233345832;7109.857802844018;7112.431005519649;7113.181984071691;7116.786496405116;4918.065567542156;4941.975290123526;5050.646454748279;5110.616703747308;5154.098032844162;4917.483664215349;5012.47369026247;5090.669106508065;5296.470352964827;5307.124324486416 06:51:05 INFO - PROCESS | 3154 | |4;prototype.html;311.9329344190999;314.8095402281621;319.7713634751153;325.95110733389976;328.5548082348418;5095.541401273885;5250.579953603712;5280.940433231043;5294.152935530311;5306.310179676641;5083.161278389061;5171.50870667286;5197.506236907498;5211.612451906253;5234.26720259164;4081.9591804081874;4101.815418306183;4113.938290925638;4134.979325103385;4159.604837540436;3897.2462391923605;4057.0871553900283;4117.135401565675;4154.127633197032;4156.729812562174;4040.656544193747;4051.5948405159397;4054.2702313583545;4055.71609987301;4056.411820286057;4034.7175697701173;4042.9595704042877;4046.817893194813;4050.5949405059555;4054.553999060101;3526.2418580005165;3559.60844307126;3583.157957879896;3597.244578638489;3607.206414588786;5057.848264552069;5093.821716239914;5094.796208151706;5096.61775366849;5106.617003724736;4618.769061546909;4619.584237418649;4621.676482646216;4635.188841952645;4635.443746750378;5350.635587925093;5404.729763511808;5416.377116631598;5436.55355090211;5444.8366549003595;3759.774413535197;3860.4402361657685;3867.6712479439;3888.8833334999995;3889.4943657324648;5536.695481748502;5560.359693890312;5568.749406276686;5581.2186293918885;5614.9157762633595;3926.9607303926596;3944.5069366329208;3946.2896678598127;3957.980210098931;4025.496812898388;3902.20004898995;3962.32640451124;3984.2828290907337;4043.4945631796027;4058.5129784425467;4555.2256116460285;4558.5897269245925;4567.840125595588;4590.357349971006;4595.518420053134;5423.972880135574;5435.157550579666;5436.776725236869;5454.4545545445135;5458.590605704588;1307.3136603283162;1338.1703343926827;1340.8256926599674;1359.1233654292926;1363.6659018540322;927.7448701607112;947.1144479911168;960.6541645007792;961.4135377419768;974.6393834281362;5248.3701955765555;5250.238715386247;5251.238570407269;5261.684298942076;5263.421023687391;5519.9980014489975;5520.503154716095;5523.917141242885;5526.668399896019;5543.196236545759;4960.603151747851;5189.117849965515;5198.948010519846;5204.817831375959;5215.687058776485;2586.922392328233;2607.6218948252776;2616.437465944831;2625.765890031682;2633.789296856247;5059.87350316245;5068.315777370081;5076.568491678248;5084.796608135707;5089.491050894881;4686.578207961232;4858.562729354375;4911.508849115131;4967.751612419437;4989.03152624188;4972.726500042532;5000.3249561309485;5037.29477873098;5095.140588323457;5096;4826.852050837344;4904.313396124474;4928.334674818853;4930.654854160318;4949.688332591938;4560.172692930271;4815;4853.781579828846;4866.440359358719;4886.9022619546695;5054.898902021865;5080;5088.262201980618;5096.261042148942;5109.386873575046;3614.4578313253223;3632;3637.308911306843;3638.4178531434845;3659.645931005545;4897.3878265216845;4900.656954013185;4911.263310503453;5220.9477905220465;5628.662280263034;5471.890562188813;5482.479164479368;5508.641938274;5516.668999860021;5526.447355264441;5461.9453805461435;5466;5472.315960504937;5491.395946445808;5495.120780675073;5262.368515778131;5445.264889239902;5468.0977638690765;5506.146547285177;5518.172274158747;5518.779248830002;5531.170324451365;5544.390117087037;5554.194641776839;5561.165825126263;5299.099153143898;5430.972845135907;5433.668751155992;5442.401335853132;5446.618736688394 06:51:05 INFO - PROCESS | 3154 | |5;yui.html;700.6321681117413;735.9889601655976;742.1428250370822;756.9016027916371;824.4023083264632;15379.231038448088;15413.306401211945;16769.077700726455;16913.746293805587;16976.490705278848;15169.241537923088;15264.771028434583;15265.160416177107;15298.69402611947;15331.540053798404;795.2604078207265;823;825.1830687619243;825.9132791056943;826.0665448043702;675.6520391998125;682.1200651160023;794.66226853587;799.8320352725934;803.4817542684965;865.4634126841368;870.1124852650292;870.5081628879663;870.7126648206108;871.5119533061475;864.1962974433774;865.7792262972964;866.4065115395974;867.3538214030525;867.4014929698487;510.3034358101165;521.405597618715;600.5525883217032;605.7001784116891;612.6660969771485;15382.769258461132;15385;15394.15332156731;15400.22998850053;15409.306581203873;13498.662533436644;13863.653408664763;14214.076085054437;14290.428382864673;14403.279836008158;12617;12736.80894786579;12745.490180392773;12776;12840.422181001784;4396.362527433536;4460.442444694413;4466.620337271336;4475.507694153641;4494.966157783695;62939.685301573656;76063.61968190124;76301;77594;77636;11198.216124871344;11393.658190254306;11673.533058677727;11681.357525336018;11751.882481175078;20787.68818467724;20899.79100209009;21024;21045.684314735292;21087.78912210858;8288.627011784363;8434.367422443342;8604;8607.096254893271;8721.215090641872;4334.5882141196535;4499.167653984024;4525.864224073283;4778.259369797687;4957.206846904478;3489.581250249986;3587.6232995535615;3607.9278414432088;3639.707903694203;3648.5804132524568;649.5647915896267;653.9673016349163;657.1785268414482;664.6145235763342;669.5781657555806;557.3423360434726;560.3555910702643;632.3897438971414;639.402158981354;656.1830521001384;7820.648070836713;8053.355731541463;8093.271605555528;8110.3511719062335;8706.389317976194;565.6012511179608;665.2814959843357;666.8066260784318;699.2692636195188;715.2954339975121;4001.139754952641;4036.5357983832237;4129.834806607762;4167.916641667211;4168.958310416918;65729.67135164293;68592.65703671549;101260;119021;122624;98143.50928245313;101314;102676.48661756644;102731;102856.48571757093;86777.56611216904;89775.55112224528;91123.54438227766;92185.53907230421;92659.53670231605;7838.294553490213;7930.127685954656;7932.6430310635005;8040.115587285511;8079.232472915063;51719.741401292755;52507;52838.73580632072;53499.465005351005;54009.18986215131;73463.26536734564;74788.25211748031;78858.6057069711;80548;81052.5947370283;10869.695636523667;10949.452527373758;10968.506417211085;11022.669319920415;11299.887001129884;12274.202176858476;12386.380680965736;12446.439910204244;12732.872671273539;12913.225206487641;11393.601223957454;11697.766044679229;11787.764244715228;11899.82150267764;12085.093617978862;10920.344779313267;10951;11441.690716333092;11516.481758321062;11540.826887596524;11169.441527923735;11253;11720;11805.468753905923;11819.290842549475;8949.284057275272;9152.954235229048;9387.765305867408;9388.76528086776;9525.095115963972;8450.450720703135;9017.864732028893;9196.448213107235;9511.809763804547;9693.321467497208 06:51:05 INFO - PROCESS | 3154 | __end_tp_report 06:51:05 INFO - PROCESS | 3154 | __start_cc_report 06:51:05 INFO - PROCESS | 3154 | _x_x_mozilla_cycle_collect,2680 06:51:05 INFO - PROCESS | 3154 | __end_cc_report 06:51:05 INFO - PROCESS | 3154 | __startTimestamp1477144265865__endTimestamp 06:51:05 INFO - PROCESS | 3154 | 06:51:05 INFO - PROCESS | 3154 | ------- Summary: start ------- 06:51:05 INFO - PROCESS | 3154 | Number of tests: 6 06:51:05 INFO - PROCESS | 3154 | 06:51:05 INFO - PROCESS | 3154 | [#0] dojo.html Cycles:165 Average:5339.29 Median:5494.75 stddev:600.60 (10.9%) stddev-sans-first:575.31 06:51:05 INFO - PROCESS | 3154 | Values: 3064.3 3064.8 3102.2 3113.4 3114.8 5320.9 5335.6 5387.8 5417.5 5440.5 5416.7 5448.9 5499.6 5521.8 5541.2 4864.2 4901.5 4954.0 4961.3 4978.4 4894.7 5038.0 5061.3 5062.3 5124.1 4803.7 4947.5 4961.6 5014.5 5074.4 4823.2 4827.1 4831.5 4838.4 4899.4 4784.5 4786.0 4790.8 4809.5 4850.9 5257.3 5270.2 5280.9 5283.0 5283.4 5619.9 5621.6 5650.8 5720.7 5728.7 5754.9 5794.3 5813.5 5817.9 5885.1 5402.1 5412.6 5413.4 5414.1 5414.3 5725.6 5914.5 5915.7 5928.7 5933.3 5530.4 5582.3 5586.3 5606.9 5684.3 5638.8 5644.6 5646.7 5648.4 5717.4 5704.5 5706.2 5709.1 5712.2 5774.2 5529.4 5572.2 5576.1 5658.5 5725.1 4414.1 4439.2 4444.4 4455.0 4459.9 3957.9 3959.1 3961.5 3988.6 4003.0 5326.8 5381.8 5509.8 5511.8 5516.4 5759.5 5788.9 5809.1 5823.5 5904.2 5414.9 5479.8 5482.6 5487.6 5488.1 4930.9 5006.7 5024.1 5025.5 5079.2 5942.6 6048.0 6095.2 6100.9 6118.1 5838.5 5838.6 5846.8 5863.4 5917.7 6019.4 6091.6 6094.1 6099.4 6101.3 5425.7 5455.7 5464.6 5551.6 5551.8 5626.5 5633.7 5635.6 5638.2 5644.5 5500.6 5506.4 5507.2 5507.7 5508.9 5453.0 5476.0 5483.2 5490.0 5494.8 5462.6 5465.3 5467.7 5471.9 5488.2 5674.3 5686.3 5700.7 5705.1 5705.9 5480.5 5594.6 5594.8 5596.0 5600.2 06:51:05 INFO - PROCESS | 3154 | 06:51:05 INFO - PROCESS | 3154 | [#1] ext.html Cycles:180 Average:56156.11 Median:20494.52 stddev:106512.50 (519.7%) stddev-sans-first:106729.50 06:51:05 INFO - PROCESS | 3154 | Values: 559.8 593.8 624.1 636.0 642.9 32443.8 42735.6 43898.8 43938.0 47289.8 44107.0 44476.0 44555.3 44591.8 44628.8 8752.9 8952.2 8972.0 8972.1 8993.4 7996.1 8227.3 10485.5 10740.3 10748.5 10860.6 10940.2 10941.7 10946.6 10954.4 8100.5 10736.1 10806.2 10812.1 10820.3 7997.3 10197.8 10563.3 10570.2 10863.8 41277.2 41384.0 41565.2 41624.4 41639.2 3386.8 3438.7 3605.1 3735.8 3927.7 31309.2 31475.0 31566.0 32662.3 33098.3 3893.6 3976.5 4015.9 4041.8 4193.2 318896.0 319843.0 321114.0 322013.0 322656.0 58035.0 58574.7 58631.1 58633.1 58635.1 35931.8 37052.3 37142.6 61116.0 61314.7 16521.3 16572.8 16575.4 16655.7 16681.5 11635.9 12164.6 12201.7 12210.6 12218.3 16381.8 18273.0 18844.9 18946.8 19241.5 6807.7 6830.0 6950.8 7021.4 7087.6 905.3 983.3 1014.3 1061.1 1094.1 32209.2 32226.5 32344.4 32654.3 32788.0 1057.4 1076.1 1078.6 1132.5 1156.4 15933.5 17030.7 17061.2 17076.9 17113.4 486994.0 489581.0 490206.0 490439.0 491689.0 56425.4 56863.0 57015.7 57015.7 57071.1 1258.0 1262.7 1296.5 1300.5 1317.3 29631.6 31056.5 31279.0 31417.4 31806.5 49339.0 49944.5 49962.3 49976.5 50002.5 379173.0 379556.0 379860.0 381846.0 383602.0 27482.9 27686.7 28058.0 28059.6 28065.6 46729.8 47295.8 47746.0 47982.5 48839.8 38370.2 40147.0 40465.8 40882.0 41619.6 40904.4 41268.6 41364.5 41404.2 41470.6 39762.4 40453.0 40573.6 41735.2 42015.0 33890.5 36324.5 36818.6 37078.6 37253.3 28049.9 28107.8 28241.6 28348.1 28518.4 06:51:05 INFO - PROCESS | 3154 | 06:51:05 INFO - PROCESS | 3154 | [#2] jquery.html Cycles:180 Average:25746.29 Median:18035.17 stddev:70428.57 (390.5%) stddev-sans-first:70600.33 06:51:05 INFO - PROCESS | 3154 | Values: 351.0 373.2 376.7 380.8 390.8 14173.4 17760.3 18292.5 18900.7 20149.8 14746.7 17565.3 18622.1 19543.6 19717.4 5494.8 5716.8 5742.3 5762.7 5786.6 4184.5 4289.4 4397.3 5668.9 5764.7 4434.0 6540.2 6546.2 6549.6 6568.0 6199.5 6351.4 6400.0 6530.2 6535.7 5593.9 5595.0 5596.9 5603.6 5604.2 21804.9 22827.5 22882.5 22947.1 23028.0 2403.2 2533.7 2585.3 2754.8 3002.1 13927.5 14486.0 14516.9 14807.6 15164.2 1835.9 1900.5 1905.8 1910.4 1992.1 78166.6 78262.0 78629.0 79092.6 80319.2 9136.7 9277.3 9573.2 10014.2 10209.8 13204.1 13425.9 13467.7 13472.1 13491.5 7767.6 7866.6 7883.9 8141.3 8142.8 7775.8 7892.2 8007.3 8076.3 8151.4 6152.5 6167.7 6243.7 6269.6 6380.3 1684.2 1705.9 1719.4 1745.8 1770.5 925.0 925.2 983.2 988.8 1037.7 19117.9 19390.8 19497.3 19526.3 19776.6 988.9 1008.7 1025.2 1071.5 1094.9 10322.1 11104.0 11228.8 11335.4 11357.4 422981.0 429354.0 430144.0 432032.0 434375.0 44503.0 47599.8 50401.5 53564.0 75416.0 990.5 996.3 1024.3 1034.9 1043.8 16908.8 16931.2 17751.4 17839.1 18088.5 35719.3 35839.3 36517.3 36942.4 36983.6 48501.3 49254.3 50047.2 51313.5 51626.7 7842.9 7901.3 7925.8 8191.2 8397.7 12111.8 12150.2 12282.3 12637.1 13000.1 10599.5 10885.3 11137.3 11299.9 11703.3 10786.5 11103.9 11327.4 11358.3 11468.5 10581.3 10631.1 10666.9 11074.0 11137.6 7859.7 7909.4 8048.1 8078.2 8085.1 10531.5 10903.1 10976.2 10986.2 11019.6 06:51:05 INFO - PROCESS | 3154 | 06:51:05 INFO - PROCESS | 3154 | [#3] mootools.html Cycles:180 Average:5962.78 Median:4847.05 stddev:3521.46 (72.7%) stddev-sans-first:3515.05 06:51:05 INFO - PROCESS | 3154 | Values: 1455.3 1490.9 1587.7 1757.4 1788.4 7499.9 7706.7 8637.2 9307.8 9313.8 8768.7 9048.9 9081.5 9311.6 9322.6 2341.1 2370.8 2375.8 2376.2 2378.6 2033.7 2083.6 2345.6 2363.2 2388.3 2302.6 2355.3 2363.4 2368.2 2381.2 2370.3 2374.0 2377.0 2378.7 2385.8 2313.5 2323.5 2327.6 2329.6 2368.0 9070.2 9119.5 9183.4 9209.0 9214.6 5256.8 5441.1 5471.4 5534.7 5552.8 3279.1 3447.3 3452.1 3464.3 3506.7 1057.4 1102.3 1110.9 1122.6 1129.3 13269.7 13307.7 13324.3 13326.3 13341.2 4420.4 4605.7 4761.0 4800.2 4845.3 10788.3 10799.5 10804.2 10806.7 10809.1 5355.8 5368.0 5368.9 5369.8 5372.7 4791.5 4848.8 4873.0 4880.7 4888.7 3712.8 3723.1 3779.5 3825.6 3899.6 1061.4 1095.6 1245.8 1276.8 1287.7 915.3 928.5 940.0 942.4 956.4 5752.4 5779.1 5854.3 6087.1 6114.3 930.6 943.1 945.6 964.5 968.0 3866.7 3982.4 3996.5 4015.7 4029.1 11331.3 11792.1 11830.0 11860.6 11863.2 11566.4 11617.7 11620.2 11654.1 11678.0 8036.7 8324.5 8348.2 8483.8 8581.1 5576.5 5720.9 5805.0 5825.6 5926.1 10044.3 10466.4 10496.5 10568.2 10648.3 10555.5 10718.5 10801.1 10888.0 10907.6 8168.6 8225.9 8236.3 8288.8 8291.0 8804.4 8865.9 8937.6 9012.4 9013.1 6214.8 7905.7 8020.7 8039.9 8333.3 7883.7 8009.3 8050.7 8069.7 8078.6 6934.1 7109.9 7112.4 7113.2 7116.8 4918.1 4942.0 5050.6 5110.6 5154.1 4917.5 5012.5 5090.7 5296.5 5307.1 06:51:05 INFO - PROCESS | 3154 | 06:51:05 INFO - PROCESS | 3154 | [#4] prototype.html Cycles:180 Average:4441.24 Median:5018.81 stddev:1291.58 (25.7%) stddev-sans-first:1257.46 06:51:05 INFO - PROCESS | 3154 | Values: 311.9 314.8 319.8 326.0 328.6 5095.5 5250.6 5280.9 5294.2 5306.3 5083.2 5171.5 5197.5 5211.6 5234.3 4082.0 4101.8 4113.9 4135.0 4159.6 3897.2 4057.1 4117.1 4154.1 4156.7 4040.7 4051.6 4054.3 4055.7 4056.4 4034.7 4043.0 4046.8 4050.6 4054.6 3526.2 3559.6 3583.2 3597.2 3607.2 5057.8 5093.8 5094.8 5096.6 5106.6 4618.8 4619.6 4621.7 4635.2 4635.4 5350.6 5404.7 5416.4 5436.6 5444.8 3759.8 3860.4 3867.7 3888.9 3889.5 5536.7 5560.4 5568.7 5581.2 5614.9 3927.0 3944.5 3946.3 3958.0 4025.5 3902.2 3962.3 3984.3 4043.5 4058.5 4555.2 4558.6 4567.8 4590.4 4595.5 5424.0 5435.2 5436.8 5454.5 5458.6 1307.3 1338.2 1340.8 1359.1 1363.7 927.7 947.1 960.7 961.4 974.6 5248.4 5250.2 5251.2 5261.7 5263.4 5520.0 5520.5 5523.9 5526.7 5543.2 4960.6 5189.1 5198.9 5204.8 5215.7 2586.9 2607.6 2616.4 2625.8 2633.8 5059.9 5068.3 5076.6 5084.8 5089.5 4686.6 4858.6 4911.5 4967.8 4989.0 4972.7 5000.3 5037.3 5095.1 5096.0 4826.9 4904.3 4928.3 4930.7 4949.7 4560.2 4815.0 4853.8 4866.4 4886.9 5054.9 5080.0 5088.3 5096.3 5109.4 3614.5 3632.0 3637.3 3638.4 3659.6 4897.4 4900.7 4911.3 5220.9 5628.7 5471.9 5482.5 5508.6 5516.7 5526.4 5461.9 5466.0 5472.3 5491.4 5495.1 5262.4 5445.3 5468.1 5506.1 5518.2 5518.8 5531.2 5544.4 5554.2 5561.2 5299.1 5431.0 5433.7 5442.4 5446.6 06:51:05 INFO - PROCESS | 3154 | 06:51:05 INFO - PROCESS | 3154 | [#5] yui.html Cycles:180 Average:20086.84 Median:52672.87 stddev:29357.59 (55.7%) stddev-sans-first:29403.85 06:51:05 INFO - PROCESS | 3154 | Values: 700.6 736.0 742.1 756.9 824.4 15379.2 15413.3 16769.1 16913.7 16976.5 15169.2 15264.8 15265.2 15298.7 15331.5 795.3 823.0 825.2 825.9 826.1 675.7 682.1 794.7 799.8 803.5 865.5 870.1 870.5 870.7 871.5 864.2 865.8 866.4 867.4 867.4 510.3 521.4 600.6 605.7 612.7 15382.8 15385.0 15394.2 15400.2 15409.3 13498.7 13863.7 14214.1 14290.4 14403.3 12617.0 12736.8 12745.5 12776.0 12840.4 4396.4 4460.4 4466.6 4475.5 4495.0 62939.7 76063.6 76301.0 77594.0 77636.0 11198.2 11393.7 11673.5 11681.4 11751.9 20787.7 20899.8 21024.0 21045.7 21087.8 8288.6 8434.4 8604.0 8607.1 8721.2 4334.6 4499.2 4525.9 4778.3 4957.2 3489.6 3587.6 3607.9 3639.7 3648.6 649.6 654.0 657.2 664.6 669.6 557.3 560.4 632.4 639.4 656.2 7820.6 8053.4 8093.3 8110.4 8706.4 565.6 665.3 666.8 699.3 715.3 4001.1 4036.5 4129.8 4167.9 4169.0 65729.7 68592.7 101260.0 119021.0 122624.0 98143.5 101314.0 102676.5 102731.0 102856.5 86777.6 89775.6 91123.5 92185.5 92659.5 7838.3 7930.1 7932.6 8040.1 8079.2 51719.7 52507.0 52838.7 53499.5 54009.2 73463.3 74788.3 78858.6 80548.0 81052.6 10869.7 10949.5 10968.5 11022.7 11299.9 12274.2 12386.4 12446.4 12732.9 12913.2 11393.6 11697.8 11787.8 11899.8 12085.1 10920.3 10951.0 11441.7 11516.5 11540.8 11169.4 11253.0 11720.0 11805.5 11819.3 8949.3 9153.0 9387.8 9388.8 9525.1 8450.5 9017.9 9196.4 9511.8 9693.3 06:51:05 INFO - PROCESS | 3154 | -------- Summary: end -------- 06:51:05 INFO - PROCESS | 3154 | 06:51:06 INFO - TEST-INFO | 3154: exit 0 06:51:06 INFO - TEST-OK | dromaeo_css | took 1119177ms 06:51:06 INFO - TEST-START | kraken 06:51:06 INFO - operating with platform_type : linux_ 06:51:06 INFO - Initialising browser for kraken test... 06:51:06 INFO - TEST-INFO | started process 3461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn53xn3/profile http://localhost:57948/getInfo.html) 06:51:10 INFO - PROCESS | 3461 | __metrics Screen width/height:1600/1200 06:51:10 INFO - PROCESS | 3461 | colorDepth:24 06:51:10 INFO - PROCESS | 3461 | Browser inner width/height: 1024/697 06:51:10 INFO - PROCESS | 3461 | __metrics 06:51:11 INFO - PROCESS | 3461 | 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" 06:51:11 INFO - PROCESS | 3461 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:51:11 INFO - PROCESS | 3461 | console.error: PushService: 06:51:11 INFO - PROCESS | 3461 | stateChangeProcessEnqueue: Error transitioning state 06:51:11 INFO - PROCESS | 3461 | UnknownError 06:51:12 INFO - TEST-INFO | 3461: exit 0 06:51:12 INFO - Browser initialized. 06:51:12 INFO - Running cycle 1/1 for kraken test... 06:51:12 INFO - TEST-INFO | started process 3545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn53xn3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:24 INFO - PROCESS | 3545 | RSS: Main: 172355584 06:51:24 INFO - PROCESS | 3545 | 06:51:27 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57948/tests/kraken/driver.html?testName=audio-beat-detection) 06:51:27 INFO - PROCESS | 3545 | RSS: Main: 237633536 06:51:27 INFO - PROCESS | 3545 | 06:51:30 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57948/tests/kraken/driver.html?testName=audio-dft) 06:51:31 INFO - PROCESS | 3545 | RSS: Main: 216424448 06:51:31 INFO - PROCESS | 3545 | 06:51:34 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57948/tests/kraken/driver.html?testName=audio-fft) 06:51:34 INFO - PROCESS | 3545 | RSS: Main: 298389504 06:51:34 INFO - PROCESS | 3545 | 06:51:36 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57948/tests/kraken/driver.html?testName=audio-oscillator) 06:51:37 INFO - PROCESS | 3545 | RSS: Main: 208736256 06:51:37 INFO - PROCESS | 3545 | 06:51:39 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57948/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:51:40 INFO - PROCESS | 3545 | RSS: Main: 212058112 06:51:40 INFO - PROCESS | 3545 | 06:51:43 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57948/tests/kraken/driver.html?testName=imaging-darkroom) 06:51:43 INFO - PROCESS | 3545 | RSS: Main: 248008704 06:51:43 INFO - PROCESS | 3545 | 06:51:47 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57948/tests/kraken/driver.html?testName=imaging-desaturate) 06:51:47 INFO - PROCESS | 3545 | RSS: Main: 247934976 06:51:47 INFO - PROCESS | 3545 | 06:51:50 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57948/tests/kraken/driver.html?testName=json-parse-financial) 06:51:50 INFO - PROCESS | 3545 | RSS: Main: 246505472 06:51:50 INFO - PROCESS | 3545 | 06:51:52 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57948/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:51:53 INFO - PROCESS | 3545 | RSS: Main: 209428480 06:51:53 INFO - PROCESS | 3545 | 06:51:54 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57948/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:51:55 INFO - PROCESS | 3545 | RSS: Main: 216567808 06:51:55 INFO - PROCESS | 3545 | 06:51:57 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57948/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:51:58 INFO - PROCESS | 3545 | RSS: Main: 226226176 06:51:58 INFO - PROCESS | 3545 | 06:52:00 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57948/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:52:01 INFO - PROCESS | 3545 | RSS: Main: 234491904 06:52:01 INFO - PROCESS | 3545 | 06:52:04 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57948/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:52:04 INFO - PROCESS | 3545 | RSS: Main: 232165376 06:52:04 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | Cycle 1(1): loaded http://localhost:57948/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57948/tests/kraken/driver.html?testName=ai-astar) 06:52:06 INFO - PROCESS | 3545 | RSS: Main: 281751552 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | __start_tp_report 06:52:06 INFO - PROCESS | 3545 | _x_x_mozilla_page_load 06:52:06 INFO - PROCESS | 3545 | _x_x_mozilla_page_load_details 06:52:06 INFO - PROCESS | 3545 | |i|pagename|runs| 06:52:06 INFO - PROCESS | 3545 | |0;ai-astar;105;110;111;110;111;111;109;110;111;109 06:52:06 INFO - PROCESS | 3545 | |1;audio-beat-detection;146;124;122;162;126;123;122;124;153;122 06:52:06 INFO - PROCESS | 3545 | |2;audio-dft;162;162;162;160;161;161;162;161;161;165 06:52:06 INFO - PROCESS | 3545 | |3;audio-fft;75;74;76;104;76;75;75;76;103;76 06:52:06 INFO - PROCESS | 3545 | |4;audio-oscillator;83;82;132;82;84;83;118;82;84;112 06:52:06 INFO - PROCESS | 3545 | |5;imaging-gaussian-blur;117;116;116;117;117;116;117;117;116;117 06:52:06 INFO - PROCESS | 3545 | |6;imaging-darkroom;145;145;146;145;145;146;145;145;145;144 06:52:06 INFO - PROCESS | 3545 | |7;imaging-desaturate;85;85;84;84;85;84;85;85;84;85 06:52:06 INFO - PROCESS | 3545 | |8;json-parse-financial;53;52;53;53;51;52;52;52;52;52 06:52:06 INFO - PROCESS | 3545 | |9;json-stringify-tinderbox;60;60;60;59;61;59;59;59;64;60 06:52:06 INFO - PROCESS | 3545 | |10;stanford-crypto-aes;82;83;87;82;80;80;80;80;81;80 06:52:06 INFO - PROCESS | 3545 | |11;stanford-crypto-ccm;134;133;132;135;138;135;135;129;175;133 06:52:06 INFO - PROCESS | 3545 | |12;stanford-crypto-pbkdf2;170;169;172;173;170;169;167;166;171;163 06:52:06 INFO - PROCESS | 3545 | |13;stanford-crypto-sha256-iterative;66;67;66;66;67;64;74;67;66;68 06:52:06 INFO - PROCESS | 3545 | __end_tp_report 06:52:06 INFO - PROCESS | 3545 | __start_cc_report 06:52:06 INFO - PROCESS | 3545 | _x_x_mozilla_cycle_collect,1674 06:52:06 INFO - PROCESS | 3545 | __end_cc_report 06:52:06 INFO - PROCESS | 3545 | __startTimestamp1477144326789__endTimestamp 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | ------- Summary: start ------- 06:52:06 INFO - PROCESS | 3545 | Number of tests: 14 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:1.83 (1.7%) stddev-sans-first:0.83 06:52:06 INFO - PROCESS | 3545 | Values: 105.0 110.0 111.0 110.0 111.0 111.0 109.0 110.0 111.0 109.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:125.00 stddev:15.20 (12.2%) stddev-sans-first:15.31 06:52:06 INFO - PROCESS | 3545 | Values: 146.0 124.0 122.0 162.0 126.0 123.0 122.0 124.0 153.0 122.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 06:52:06 INFO - PROCESS | 3545 | Values: 162.0 162.0 162.0 160.0 161.0 161.0 162.0 161.0 161.0 165.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:11.88 (15.7%) stddev-sans-first:12.40 06:52:06 INFO - PROCESS | 3545 | Values: 75.0 74.0 76.0 104.0 76.0 75.0 75.0 76.0 103.0 76.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:82.50 stddev:18.91 (22.9%) stddev-sans-first:19.62 06:52:06 INFO - PROCESS | 3545 | Values: 83.0 82.0 132.0 82.0 84.0 83.0 118.0 82.0 84.0 112.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:52:06 INFO - PROCESS | 3545 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 06:52:06 INFO - PROCESS | 3545 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 144.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 06:52:06 INFO - PROCESS | 3545 | Values: 85.0 85.0 84.0 84.0 85.0 84.0 85.0 85.0 84.0 85.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 06:52:06 INFO - PROCESS | 3545 | Values: 53.0 52.0 53.0 53.0 51.0 52.0 52.0 52.0 52.0 52.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.52 (2.5%) stddev-sans-first:1.62 06:52:06 INFO - PROCESS | 3545 | Values: 60.0 60.0 60.0 59.0 61.0 59.0 59.0 59.0 64.0 60.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:2.22 (2.7%) stddev-sans-first:2.35 06:52:06 INFO - PROCESS | 3545 | Values: 82.0 83.0 87.0 82.0 80.0 80.0 80.0 80.0 81.0 80.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:135.00 stddev:13.25 (9.8%) stddev-sans-first:13.97 06:52:06 INFO - PROCESS | 3545 | Values: 134.0 133.0 132.0 135.0 138.0 135.0 135.0 129.0 175.0 133.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:2.98 (1.8%) stddev-sans-first:3.14 06:52:06 INFO - PROCESS | 3545 | Values: 170.0 169.0 172.0 173.0 170.0 169.0 167.0 166.0 171.0 163.0 06:52:06 INFO - PROCESS | 3545 | 06:52:06 INFO - PROCESS | 3545 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.64 (3.9%) stddev-sans-first:2.77 06:52:06 INFO - PROCESS | 3545 | Values: 66.0 67.0 66.0 66.0 67.0 64.0 74.0 67.0 66.0 68.0 06:52:06 INFO - PROCESS | 3545 | -------- Summary: end -------- 06:52:06 INFO - PROCESS | 3545 | 06:52:07 INFO - TEST-INFO | 3545: exit 0 06:52:07 INFO - TEST-OK | kraken | took 61166ms 06:52:07 INFO - SUITE-END | took 1180s 06:52:07 INFO - Completed test suite (00:19:40) 06:52:07 INFO - javascript benchmark 06:52:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.2645765016405, 3064.800787948783, 3102.1934297082767, 3113.3928883867643, 3114.7663925205616, 5320.893582128355, 5335.573154147669, 5387.757550910209, 5417.45825417458, 5440.510354068133, 5416.702081385522, 5448.945510544893, 5499.560035197184, 5521.779128834842, 5541.196526503654, 4864.221724524077, 4901.53435423636, 4953.9504604953845, 4961.330220420251, 4978.402591688984, 4894.657373983805, 5038.0, 5061.316722242487, 5062.291279220912, 5124.103281925667, 4803.663743537953, 4947.529984651488, 4961.627877909171, 5014.473480284572, 5074.416442109149, 4823.228283474662, 4827.08285425768, 4831.541003604652, 4838.395200599925, 4899.436564795059, 4784.545468180518, 4786.0, 4790.760461976887, 4809.470958194595, 4850.902981940377, 5257.342832145981, 5270.156774916033, 5280.894382112375, 5283.049051170788, 5283.365996080456, 5619.915701264485, 5621.634593751393, 5650.773969041234, 5720.742566584514, 5728.656280623176, 5754.884902301972, 5794.333651630074, 5813.505852002585, 5817.883642327172, 5885.058390657474, 5402.054640437907, 5412.648177868466, 5413.404525502192, 5414.133738601844, 5414.269073675004, 5725.570582206351, 5914.497267732205, 5915.674637894871, 5928.67392293428, 5933.2880054393745, 5530.446955304518, 5582.302212223472, 5586.329640443173, 5606.887862242732, 5684.289463817023, 5638.830835074954, 5644.6330988485615, 5646.745896434671, 5648.406917273709, 5717.428257174332, 5704.486596206279, 5706.172604972256, 5709.05800542914, 5712.200291959129, 5774.220480235199, 5529.391766905637, 5572.164175373727, 5576.1356989666665, 5658.490735833712, 5725.083986562214, 4414.073044660593, 4439.223135951195, 4444.400005999149, 4455.04216593434, 4459.888502787457, 3957.881263562098, 3959.089409435788, 3961.485006949136, 3988.641022308006, 4003.039270575099, 5326.786928522815, 5381.838544843661, 5509.752061157177, 5511.834644960658, 5516.365617953987, 5759.539236861041, 5788.942110578841, 5809.09958956354, 5823.505002074871, 5904.1734157218025, 5414.864628384243, 5479.835604931858, 5482.643628164156, 5487.5884308677005, 5488.067028605146, 4930.926036109461, 5006.724630145377, 5024.145984245714, 5025.522575355409, 5079.212722028092, 5942.64344139353, 6048.002079656895, 6095.238095238095, 6100.938990610214, 6118.13190915367, 5838.532917366516, 5838.649681019152, 5846.766129354778, 5863.384344643751, 5917.6745279010065, 6019.367966363468, 6091.573589848668, 6094.055421409688, 6099.359567245376, 6101.267847858286, 5425.701586412785, 5455.672659640434, 5464.590155738415, 5551.555875529867, 5551.7779288828, 5626.549876009991, 5633.6619802811965, 5635.605507614591, 5638.210650509014, 5644.463775941279, 5500.5874559409, 5506.449355064461, 5507.173923911445, 5507.7246137692155, 5508.944910551004, 5453.0, 5476.041692703681, 5483.217954164833, 5489.984352894728, 5494.752736126804, 5462.617616766788, 5465.289512363526, 5467.6719396836315, 5471.863203419787, 5488.1767734838495, 5674.319081710221, 5686.346070201815, 5700.714964251853, 5705.058665320175, 5705.857353566194, 5480.506754391964, 5594.552435805207, 5594.804181853616, 5596.048671725735, 5600.215969764155], "value": 5299.029622144774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.846042338357, 593.7565598104775, 624.0670198053907, 635.9745610175593, 642.8842808294505, 32443.837780811093, 42735.57264427355, 43898.78050609751, 43938.0, 47289.76355118228, 44107.0, 44476.0, 44555.33167002498, 44591.77704111483, 44628.77685611568, 8752.868706969384, 8952.194302512773, 8971.95514022429, 8972.147645973622, 8993.370464067519, 7996.08045074818, 8227.259546640802, 10485.528151233175, 10740.301880377789, 10748.516316765725, 10860.61987830426, 10940.23418360715, 10941.671749847477, 10946.56213751449, 10954.39750813705, 8100.513969161811, 10736.141108711285, 10806.243562950596, 10812.135029197685, 10820.296680715806, 7997.320227780646, 10197.796044079078, 10563.26057175998, 10570.15438764897, 10863.782724345549, 41277.174456511, 41384.0, 41565.1686966259, 41624.37563436551, 41639.1672166558, 3386.8306584670913, 3438.707709844666, 3605.1167463971233, 3735.794531300777, 3927.6857851372106, 31309.217269568217, 31475.0, 31566.0, 32662.346753065045, 33098.3380332392, 3893.552241492236, 3976.5029371328583, 4015.859444919414, 4041.7574945503366, 4193.224253513079, 318896.0, 319843.0, 321114.0, 322013.0, 322656.0, 58035.0, 58574.70712646495, 58631.120533192036, 58633.120503192484, 58635.12047319294, 35931.82034089865, 37052.258954820754, 37142.62857371392, 61116.0, 61314.65678849427, 16521.33914643401, 16572.75140872888, 16575.41986030483, 16655.6668866622, 16681.499555013368, 11635.88364116365, 12164.635060948185, 12201.694957625952, 12210.57262995791, 12218.266903985612, 16381.754273685905, 18273.0, 18844.90577547131, 18946.810531894782, 19241.51896202578, 6807.727690892309, 6830.0, 6950.79147625572, 7021.419076271139, 7087.645617719093, 905.2622112977901, 983.3215081593678, 1014.3305418423805, 1061.1086687182803, 1094.0864378244096, 32209.194770130467, 32226.516602250984, 32344.35311293761, 32654.346913061607, 32788.0, 1057.3867157048894, 1076.1390887290293, 1078.5901357484263, 1132.4847194526471, 1156.3813359852438, 15933.521994340188, 17030.74453883193, 17061.232244548777, 17076.914615426842, 17113.401030964105, 486994.0, 489581.0, 490206.0, 490439.0, 491689.0, 56425.43574564284, 56863.0, 57015.714921425126, 57015.714921425955, 57071.14393284104, 1257.9748405031849, 1262.671705356614, 1296.5138073222543, 1300.5188080410119, 1317.3215793866166, 29631.555526667547, 31056.534151987285, 31279.0, 31417.37165256728, 31806.52290215695, 49339.0, 49944.50055499398, 49962.25056624226, 49976.50023499864, 50002.49997500124, 379173.0, 379556.0, 379860.0, 381846.0, 383602.0, 27482.862585686944, 27686.723132768413, 28058.0, 28059.579106313013, 28065.57901631518, 46729.76635116803, 47295.763521182176, 47746.0, 47982.520174797806, 48839.755801222185, 38370.2325953485, 40147.0, 40465.79767101146, 40882.0, 41619.58380416157, 40904.38643420291, 41268.587314127675, 41364.537724080976, 41404.1719165621, 41470.58529414667, 39762.40356394598, 40453.0, 40573.55124814424, 41735.16529669329, 42015.0, 33890.49164262587, 36324.455133172494, 36818.631813682594, 37078.629213707514, 37253.25493490169, 28049.859750701933, 28107.773118693432, 28241.550695825048, 28348.100570378385, 28518.42963140767], "value": 19898.07398973344, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.04515717249075, 373.1994871001701, 376.6610050954143, 380.76012112369204, 390.79287977371985, 14173.362198701057, 17760.289588416465, 18292.45122646321, 18900.716489252638, 20149.798502014975, 14746.705065898675, 17565.29738810446, 18622.068896555185, 19543.609127817435, 19717.408477745656, 5494.80768173114, 5716.77132914685, 5742.253507044099, 5762.711864406784, 5786.594938354317, 4184.456020717303, 4289.356596510533, 4397.296432570789, 5668.858278543028, 5764.682942438164, 4434.002349471375, 6540.182477190351, 6546.214454265495, 6549.607023578576, 6568.014797780347, 6199.504039676837, 6351.428371446592, 6399.968000160016, 6530.2163740351225, 6535.738570457176, 5593.916091258634, 5595.048841696921, 5596.944030559724, 5603.579731520153, 5604.243427137325, 21804.89097554518, 22827.54344913109, 22882.542349152925, 22947.08211671531, 23027.963741631665, 2403.218953840009, 2533.6698233427414, 2585.301968468522, 2754.834709917411, 3002.0993701889347, 13927.512537061255, 14486.0, 14516.927415362961, 14807.555773326818, 15164.24178791056, 1835.8990255535941, 1900.47536668666, 1905.8284754372035, 1910.4459706685045, 1992.1035534009754, 78166.6091669538, 78262.0, 78629.0, 79092.60453697752, 80319.19680803176, 9136.680216192533, 9277.304202184863, 9573.18627916621, 10014.198864090855, 10209.846852297222, 13204.075714699879, 13425.932870335586, 13467.663308417172, 13472.12431191989, 13491.460341586228, 7767.572783496962, 7866.567338796307, 7883.881741773878, 8141.307988821017, 8142.796430089176, 7775.805604859924, 7892.210778922176, 8007.319377852831, 8076.313513351313, 8151.429399941947, 6152.477039451607, 6167.722452489649, 6243.687815609202, 6269.62382257066, 6380.298167201604, 1684.1915880377487, 1705.8976461412108, 1719.3982106262958, 1745.7817772778403, 1770.5131088950384, 924.995375023134, 925.167349385545, 983.1986930651497, 988.8318985772436, 1037.699067270483, 19117.90441047786, 19390.806091939183, 19497.317593884145, 19526.31657891967, 19776.60446791085, 988.8912219655832, 1008.6570566007592, 1025.1593693171528, 1071.5499490214129, 1094.9452527373758, 10322.12261957727, 11104.000639942444, 11228.831567526493, 11335.43322833855, 11357.375344355974, 422981.0, 429354.0, 430144.0, 432032.0, 434375.0, 44503.0, 47599.762001189774, 50401.49598504041, 53563.99999999922, 75416.0, 990.4552496127101, 996.3175224970918, 1024.3341827811983, 1034.8758149022165, 1043.7912417516375, 16908.830911691217, 16931.238094286033, 17751.378701745893, 17839.10804459798, 18088.547786305448, 35719.28561428809, 35839.28321433609, 36517.26965460729, 36942.445863311536, 36983.6301636991, 48501.27248091211, 49254.26118608296, 50047.249291259934, 51313.48686513087, 51626.74186629043, 7842.882356764767, 7901.288884000468, 7925.762227133196, 8191.221833925768, 8397.664093436195, 12111.81832272499, 12150.21023633461, 12282.32447215376, 12637.052221083639, 13000.08999370035, 10599.523021464207, 10885.292455990335, 11137.331760094421, 11299.887001129884, 11703.29780213156, 10786.460676966277, 11103.888961110608, 11327.376994265394, 11358.318500889973, 11468.541258349906, 10581.31221470602, 10631.149508039493, 10666.89333106659, 11074.0, 11137.554497819996, 7859.724909628136, 7909.446338756462, 8048.1147073823, 8078.232567906274, 8085.070216925129, 10531.473426328806, 10903.12774977984, 10976.231663783778, 10986.176036797113, 11019.559217631206], "value": 8926.540365724062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.323274677275, 1490.9030912990654, 1587.6824635072987, 1757.376131473326, 1788.4098247578293, 7499.850002999937, 7706.6917323307, 8637.179467950551, 9307.81384372313, 9313.81372372553, 8768.736937891857, 9048.864267035984, 9081.545922703855, 9311.58097885595, 9322.580483878224, 2341.063574570173, 2370.751071137523, 2375.809935205188, 2376.2158487699016, 2378.63131214662, 2033.6949457581406, 2083.6145313117045, 2345.636426353918, 2363.2201373546773, 2388.3312672451652, 2302.643090321003, 2355.3169580821627, 2363.3737059679197, 2368.1829768729845, 2381.226101517014, 2370.2889133260123, 2374.03851440167, 2377.037299893546, 2378.6907701998803, 2385.809135269183, 2313.5257272259146, 2323.5352929414184, 2327.569399661068, 2329.592321343775, 2367.9644805327935, 9070.18368346852, 9119.49842758648, 9183.44899306037, 9209.0, 9214.585343659484, 5256.789728410859, 5441.075017247077, 5471.425500322449, 5534.667919924777, 5552.833414997556, 3279.147421670359, 3447.258839349552, 3452.1369657585606, 3464.34177506273, 3506.7019303359243, 1057.4237040812775, 1102.3000394749313, 1110.8889111088906, 1122.5902545570807, 1129.2829053551054, 13269.668258293523, 13307.733845323039, 13324.333783310893, 13326.267055311953, 13341.19952802835, 4420.381146639473, 4605.677602567788, 4761.0, 4800.183968725325, 4845.273209018605, 10788.298760580537, 10799.460026998775, 10804.243702940876, 10806.675799726021, 10809.135269178447, 5355.812546560852, 5368.0, 5368.946310536845, 5369.838904832861, 5372.70450125239, 4791.544803243686, 4848.8302909398, 4872.9512704873205, 4880.658353915192, 4888.682235654671, 3712.832922518493, 3723.106454450912, 3779.527559055118, 3825.6365645263654, 3899.629535194152, 1061.395004847245, 1095.638439315024, 1245.8255844181822, 1276.7957126859844, 1287.7251520994148, 915.2769312243387, 928.535732133933, 939.9718008459757, 942.3649967306717, 956.364017928084, 5752.424757524214, 5779.104238842986, 5854.268216472941, 6087.05650624154, 6114.296855861633, 930.5858892792643, 943.1417410156724, 945.5697657565792, 964.4984608003799, 967.9951600241953, 3866.709996750255, 3982.3628219484744, 3996.500437445319, 4015.6586690131667, 4029.1135950090934, 11331.263467874562, 11792.056635469142, 11830.0, 11860.644180674593, 11863.228890122115, 11566.42167891602, 11617.709557260967, 11620.244684095507, 11654.067674586013, 11678.007369373698, 8036.718714844952, 8324.542150181676, 8348.165183481604, 8483.787905302417, 8581.141885811368, 5576.525995290283, 5720.914186287126, 5805.0, 5825.563082768894, 5926.081457374114, 10044.296899216984, 10466.424346661006, 10496.52765625564, 10568.20738444635, 10648.307859989076, 10555.525001374803, 10718.517666704862, 10801.135909127408, 10888.020078193, 10907.618233361794, 8168.632411541376, 8225.876611850947, 8236.299914507093, 8288.792780180544, 8291.0, 8804.383693141419, 8865.867011994955, 8937.642494300155, 9012.369134160546, 9013.053629368822, 6214.8135555933395, 7905.6837726492595, 8020.719274825353, 8039.879401809095, 8333.250007499355, 7883.684652614061, 8009.279164875189, 8050.718224862102, 8069.677212911418, 8078.555679437687, 6934.133233345832, 7109.857802844018, 7112.431005519649, 7113.181984071691, 7116.786496405116, 4918.065567542156, 4941.975290123526, 5050.646454748279, 5110.616703747308, 5154.098032844162, 4917.483664215349, 5012.47369026247, 5090.669106508065, 5296.470352964827, 5307.124324486416], "value": 4709.027326792504, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.9329344190999, 314.8095402281621, 319.7713634751153, 325.95110733389976, 328.5548082348418, 5095.541401273885, 5250.579953603712, 5280.940433231043, 5294.152935530311, 5306.310179676641, 5083.161278389061, 5171.50870667286, 5197.506236907498, 5211.612451906253, 5234.26720259164, 4081.9591804081874, 4101.815418306183, 4113.938290925638, 4134.979325103385, 4159.604837540436, 3897.2462391923605, 4057.0871553900283, 4117.135401565675, 4154.127633197032, 4156.729812562174, 4040.656544193747, 4051.5948405159397, 4054.2702313583545, 4055.71609987301, 4056.411820286057, 4034.7175697701173, 4042.9595704042877, 4046.817893194813, 4050.5949405059555, 4054.553999060101, 3526.2418580005165, 3559.60844307126, 3583.157957879896, 3597.244578638489, 3607.206414588786, 5057.848264552069, 5093.821716239914, 5094.796208151706, 5096.61775366849, 5106.617003724736, 4618.769061546909, 4619.584237418649, 4621.676482646216, 4635.188841952645, 4635.443746750378, 5350.635587925093, 5404.729763511808, 5416.377116631598, 5436.55355090211, 5444.8366549003595, 3759.774413535197, 3860.4402361657685, 3867.6712479439, 3888.8833334999995, 3889.4943657324648, 5536.695481748502, 5560.359693890312, 5568.749406276686, 5581.2186293918885, 5614.9157762633595, 3926.9607303926596, 3944.5069366329208, 3946.2896678598127, 3957.980210098931, 4025.496812898388, 3902.20004898995, 3962.32640451124, 3984.2828290907337, 4043.4945631796027, 4058.5129784425467, 4555.2256116460285, 4558.5897269245925, 4567.840125595588, 4590.357349971006, 4595.518420053134, 5423.972880135574, 5435.157550579666, 5436.776725236869, 5454.4545545445135, 5458.590605704588, 1307.3136603283162, 1338.1703343926827, 1340.8256926599674, 1359.1233654292926, 1363.6659018540322, 927.7448701607112, 947.1144479911168, 960.6541645007792, 961.4135377419768, 974.6393834281362, 5248.3701955765555, 5250.238715386247, 5251.238570407269, 5261.684298942076, 5263.421023687391, 5519.9980014489975, 5520.503154716095, 5523.917141242885, 5526.668399896019, 5543.196236545759, 4960.603151747851, 5189.117849965515, 5198.948010519846, 5204.817831375959, 5215.687058776485, 2586.922392328233, 2607.6218948252776, 2616.437465944831, 2625.765890031682, 2633.789296856247, 5059.87350316245, 5068.315777370081, 5076.568491678248, 5084.796608135707, 5089.491050894881, 4686.578207961232, 4858.562729354375, 4911.508849115131, 4967.751612419437, 4989.03152624188, 4972.726500042532, 5000.3249561309485, 5037.29477873098, 5095.140588323457, 5096.0, 4826.852050837344, 4904.313396124474, 4928.334674818853, 4930.654854160318, 4949.688332591938, 4560.172692930271, 4815.0, 4853.781579828846, 4866.440359358719, 4886.9022619546695, 5054.898902021865, 5080.0, 5088.262201980618, 5096.261042148942, 5109.386873575046, 3614.4578313253223, 3632.0, 3637.308911306843, 3638.4178531434845, 3659.645931005545, 4897.3878265216845, 4900.656954013185, 4911.263310503453, 5220.9477905220465, 5628.662280263034, 5471.890562188813, 5482.479164479368, 5508.641938274, 5516.668999860021, 5526.447355264441, 5461.9453805461435, 5466.0, 5472.315960504937, 5491.395946445808, 5495.120780675073, 5262.368515778131, 5445.264889239902, 5468.0977638690765, 5506.146547285177, 5518.172274158747, 5518.779248830002, 5531.170324451365, 5544.390117087037, 5554.194641776839, 5561.165825126263, 5299.099153143898, 5430.972845135907, 5433.668751155992, 5442.401335853132, 5446.618736688394], "value": 4032.5809260286733, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.6321681117413, 735.9889601655976, 742.1428250370822, 756.9016027916371, 824.4023083264632, 15379.231038448088, 15413.306401211945, 16769.077700726455, 16913.746293805587, 16976.490705278848, 15169.241537923088, 15264.771028434583, 15265.160416177107, 15298.69402611947, 15331.540053798404, 795.2604078207265, 823.0, 825.1830687619243, 825.9132791056943, 826.0665448043702, 675.6520391998125, 682.1200651160023, 794.66226853587, 799.8320352725934, 803.4817542684965, 865.4634126841368, 870.1124852650292, 870.5081628879663, 870.7126648206108, 871.5119533061475, 864.1962974433774, 865.7792262972964, 866.4065115395974, 867.3538214030525, 867.4014929698487, 510.3034358101165, 521.405597618715, 600.5525883217032, 605.7001784116891, 612.6660969771485, 15382.769258461132, 15385.0, 15394.15332156731, 15400.22998850053, 15409.306581203873, 13498.662533436644, 13863.653408664763, 14214.076085054437, 14290.428382864673, 14403.279836008158, 12617.0, 12736.80894786579, 12745.490180392773, 12776.0, 12840.422181001784, 4396.362527433536, 4460.442444694413, 4466.620337271336, 4475.507694153641, 4494.966157783695, 62939.685301573656, 76063.61968190124, 76301.0, 77594.0, 77636.0, 11198.216124871344, 11393.658190254306, 11673.533058677727, 11681.357525336018, 11751.882481175078, 20787.68818467724, 20899.79100209009, 21024.0, 21045.684314735292, 21087.78912210858, 8288.627011784363, 8434.367422443342, 8604.0, 8607.096254893271, 8721.215090641872, 4334.5882141196535, 4499.167653984024, 4525.864224073283, 4778.259369797687, 4957.206846904478, 3489.581250249986, 3587.6232995535615, 3607.9278414432088, 3639.707903694203, 3648.5804132524568, 649.5647915896267, 653.9673016349163, 657.1785268414482, 664.6145235763342, 669.5781657555806, 557.3423360434726, 560.3555910702643, 632.3897438971414, 639.402158981354, 656.1830521001384, 7820.648070836713, 8053.355731541463, 8093.271605555528, 8110.3511719062335, 8706.389317976194, 565.6012511179608, 665.2814959843357, 666.8066260784318, 699.2692636195188, 715.2954339975121, 4001.139754952641, 4036.5357983832237, 4129.834806607762, 4167.916641667211, 4168.958310416918, 65729.67135164293, 68592.65703671549, 101260.0, 119021.0, 122624.0, 98143.50928245313, 101314.0, 102676.48661756644, 102731.0, 102856.48571757093, 86777.56611216904, 89775.55112224528, 91123.54438227766, 92185.53907230421, 92659.53670231605, 7838.294553490213, 7930.127685954656, 7932.6430310635005, 8040.115587285511, 8079.232472915063, 51719.741401292755, 52507.0, 52838.73580632072, 53499.465005351005, 54009.18986215131, 73463.26536734564, 74788.25211748031, 78858.6057069711, 80548.0, 81052.5947370283, 10869.695636523667, 10949.452527373758, 10968.506417211085, 11022.669319920415, 11299.887001129884, 12274.202176858476, 12386.380680965736, 12446.439910204244, 12732.872671273539, 12913.225206487641, 11393.601223957454, 11697.766044679229, 11787.764244715228, 11899.82150267764, 12085.093617978862, 10920.344779313267, 10951.0, 11441.690716333092, 11516.481758321062, 11540.826887596524, 11169.441527923735, 11253.0, 11720.0, 11805.468753905923, 11819.290842549475, 8949.284057275272, 9152.954235229048, 9387.765305867408, 9388.76528086776, 9525.095115963972, 8450.450720703135, 9017.864732028893, 9196.448213107235, 9511.809763804547, 9693.321467497208], "value": 7196.841467816609, "unit": "score"}], "name": "dromaeo_css", "value": 7105.02248693331, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 111.0, 110.0, 111.0, 111.0, 109.0, 110.0, 111.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 124.0, 122.0, 162.0, 126.0, 123.0, 122.0, 124.0, 153.0, 122.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0, 165.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 104.0, 76.0, 75.0, 75.0, 76.0, 103.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 132.0, 82.0, 84.0, 83.0, 118.0, 82.0, 84.0, 112.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 144.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 61.0, 59.0, 59.0, 59.0, 64.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 87.0, 82.0, 80.0, 80.0, 80.0, 80.0, 81.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 132.0, 135.0, 138.0, 135.0, 135.0, 129.0, 175.0, 133.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 172.0, 173.0, 170.0, 169.0, 167.0, 166.0, 171.0, 163.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 64.0, 74.0, 67.0, 66.0, 68.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1493.1000000000001, "alertThreshold": 2.0}]} 06:52:08 INFO - Return code: 0 06:52:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:52:08 INFO - # TBPL SUCCESS # 06:52:08 INFO - Running post-action listener: _resource_record_post_action 06:52:08 INFO - [mozharness: 2016-10-22 13:52:08.099633Z] Finished run-tests step (success) 06:52:08 INFO - Running post-run listener: _resource_record_post_run 06:52:08 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399851520; Read time: 4; Write time: 284908 06:52:08 INFO - TinderboxPrint: CPU usage
13.1% 06:52:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:52:08 INFO - TinderboxPrint: I/O write bytes / time
399,851,520 / 284,908 06:52:08 INFO - TinderboxPrint: CPU idle
8,297.6 (86.9%) 06:52:08 INFO - TinderboxPrint: CPU user
1,203.0 (12.6%) 06:52:08 INFO - TinderboxPrint: Swap in / out
0 / 0 06:52:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111812608; Read time: 0; Write time: 94988 06:52:08 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287555584; Read time: 0; Write time: 189916 06:52:08 INFO - Running post-run listener: _upload_blobber_files 06:52:08 INFO - Blob upload gear active. 06:52:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:52:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:52:09 INFO - (blobuploader) - INFO - Open directory for files ... 06:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:52:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:09 INFO - (blobuploader) - INFO - Done attempting. 06:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:52:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:13 INFO - (blobuploader) - INFO - Done attempting. 06:52:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:52:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:52:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:14 INFO - (blobuploader) - INFO - Done attempting. 06:52:14 INFO - (blobuploader) - INFO - Iteration through files over. 06:52:14 INFO - Return code: 0 06:52:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:52:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:52:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/70ad57ef496230237519ee35517ecf207605e5dbf03496b873c4f4aeb84aedad13d0cb186cafb6ed8c7bd93877873ed514abfe82e756acf1cc4fe3ccc3b79a94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eface2fba863f345948d55a91d18a46d3a8356967a8b3306ac78cd56e4aaf8c2cf9794732e2ab7b3da248c762e5c1856e6afa95a97620582e6121c61a7c95053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2775640fb8905cd7b066fe9ad483083b4b442514260854fa4e48c85109d96ab2cc8ae80bd606c640fad67b8543b0922731ed5695b7ba5fe46df36e4bc6dff30a"} 06:52:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:52:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:52:14 INFO - Contents: 06:52:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/70ad57ef496230237519ee35517ecf207605e5dbf03496b873c4f4aeb84aedad13d0cb186cafb6ed8c7bd93877873ed514abfe82e756acf1cc4fe3ccc3b79a94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eface2fba863f345948d55a91d18a46d3a8356967a8b3306ac78cd56e4aaf8c2cf9794732e2ab7b3da248c762e5c1856e6afa95a97620582e6121c61a7c95053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2775640fb8905cd7b066fe9ad483083b4b442514260854fa4e48c85109d96ab2cc8ae80bd606c640fad67b8543b0922731ed5695b7ba5fe46df36e4bc6dff30a"} 06:52:14 INFO - Running post-run listener: copy_logs_to_upload_dir 06:52:14 INFO - Copying logs to upload dir... 06:52:14 INFO - mkdir: /builds/slave/test/build/upload/logs 06:52:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.366641 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-22 06:52:12.913073) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 06:52:12.920729) ========= 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=6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/70ad57ef496230237519ee35517ecf207605e5dbf03496b873c4f4aeb84aedad13d0cb186cafb6ed8c7bd93877873ed514abfe82e756acf1cc4fe3ccc3b79a94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eface2fba863f345948d55a91d18a46d3a8356967a8b3306ac78cd56e4aaf8c2cf9794732e2ab7b3da248c762e5c1856e6afa95a97620582e6121c61a7c95053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2775640fb8905cd7b066fe9ad483083b4b442514260854fa4e48c85109d96ab2cc8ae80bd606c640fad67b8543b0922731ed5695b7ba5fe46df36e4bc6dff30a"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477132201/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/70ad57ef496230237519ee35517ecf207605e5dbf03496b873c4f4aeb84aedad13d0cb186cafb6ed8c7bd93877873ed514abfe82e756acf1cc4fe3ccc3b79a94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eface2fba863f345948d55a91d18a46d3a8356967a8b3306ac78cd56e4aaf8c2cf9794732e2ab7b3da248c762e5c1856e6afa95a97620582e6121c61a7c95053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2775640fb8905cd7b066fe9ad483083b4b442514260854fa4e48c85109d96ab2cc8ae80bd606c640fad67b8543b0922731ed5695b7ba5fe46df36e4bc6dff30a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 06:52:12.949539) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:52:12.949915) ========= 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=6dbc10da6d83fee962c624be000001a8-1477143091.94178-2115959233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:52:13.031251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 06:52:13.031593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 06:52:13.031892) ========= ========= Total master_lag: 0.30 =========