builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1477838232.94 results: success (0) buildid: 20161030061439 builduid: 3524a65267224dcb9dca318a5ce13b4d revision: a3b6b6e39c7965561fc750d022bee96055731226 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:12.939177) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:12.939747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:12.940151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:12.956143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:12.956638) ========= 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=db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 07:37:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.2M=0s 2016-10-30 07:37:13 (51.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:13.062827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:13.063144) ========= 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=db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020677 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:13.113486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:13.113848) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a3b6b6e39c7965561fc750d022bee96055731226 --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 a3b6b6e39c7965561fc750d022bee96055731226 --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=db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 07:37:13,568 truncating revision to first 12 chars 2016-10-30 07:37:13,568 Setting DEBUG logging. 2016-10-30 07:37:13,568 attempt 1/10 2016-10-30 07:37:13,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a3b6b6e39c79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 07:37:14,217 unpacking tar archive at: mozilla-inbound-a3b6b6e39c79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.958432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:14.085740) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:14.086061) ========= script_repo_revision: a3b6b6e39c7965561fc750d022bee96055731226 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:14.086451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:14.086716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:37:14.096867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-30 07:37:14.097247) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:14 INFO - MultiFileLogger online at 20161030 07:37:14 in /builds/slave/test 07:37:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:37:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:14 INFO - {'append_to_log': False, 07:37:14 INFO - 'base_work_dir': '/builds/slave/test', 07:37:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:37:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:14 INFO - 'branch': 'Mozilla-Inbound', 07:37:14 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:14 INFO - 'config_files': ('talos/linux_config.py',), 07:37:14 INFO - 'default_actions': ('clobber', 07:37:14 INFO - 'read-buildbot-config', 07:37:14 INFO - 'download-and-extract', 07:37:14 INFO - 'populate-webroot', 07:37:14 INFO - 'create-virtualenv', 07:37:14 INFO - 'install', 07:37:14 INFO - 'run-tests'), 07:37:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:14 INFO - 'download_minidump_stackwalk': True, 07:37:14 INFO - 'download_symbols': 'ondemand', 07:37:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:14 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:14 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:14 INFO - 'installer_path': 'installer.exe', 07:37:14 INFO - 'log_level': 'info', 07:37:14 INFO - 'log_name': 'talos', 07:37:14 INFO - 'log_to_console': True, 07:37:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:14 INFO - 'opt_config_files': (), 07:37:14 INFO - 'pip_index': False, 07:37:14 INFO - 'sps_profile': False, 07:37:14 INFO - 'sps_profile_interval': 0, 07:37:14 INFO - 'suite': 'dromaeojs-e10s', 07:37:14 INFO - 'system_bits': '32', 07:37:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:14 INFO - 'title': 'talos-linux64-ix-031', 07:37:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:14 INFO - 'use_talos_json': True, 07:37:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:14 INFO - 'work_dir': 'build'} 07:37:14 INFO - [mozharness: 2016-10-30 14:37:14.655674Z] Running clobber step. 07:37:14 INFO - Running pre-action listener: _resource_record_pre_action 07:37:14 INFO - Running main action method: clobber 07:37:14 INFO - rmtree: /builds/slave/test/build 07:37:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:15 INFO - Running post-action listener: _resource_record_post_action 07:37:15 INFO - [mozharness: 2016-10-30 14:37:15.632365Z] Finished clobber step (success) 07:37:15 INFO - [mozharness: 2016-10-30 14:37:15.632464Z] Running read-buildbot-config step. 07:37:15 INFO - Running pre-action listener: _resource_record_pre_action 07:37:15 INFO - Running main action method: read_buildbot_config 07:37:15 INFO - Using buildbot properties: 07:37:15 INFO - { 07:37:15 INFO - "project": "", 07:37:15 INFO - "product": "firefox", 07:37:15 INFO - "script_repo_revision": "production", 07:37:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:37:15 INFO - "repository": "", 07:37:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:37:15 INFO - "buildid": "20161030061439", 07:37:15 INFO - "stage_platform": "linux64-pgo", 07:37:15 INFO - "basedir": "/builds/slave/test", 07:37:15 INFO - "buildnumber": 1680, 07:37:15 INFO - "platform": "ubuntu64_hw", 07:37:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:37:15 INFO - "slavebuilddir": "test", 07:37:15 INFO - "branch": "mozilla-inbound", 07:37:15 INFO - "revision": "a3b6b6e39c7965561fc750d022bee96055731226", 07:37:15 INFO - "slavename": "talos-linux64-ix-031", 07:37:15 INFO - "builduid": "3524a65267224dcb9dca318a5ce13b4d", 07:37:15 INFO - "repo_path": "integration/mozilla-inbound" 07:37:15 INFO - } 07:37:15 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:37:15 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 07:37:15 INFO - Running post-action listener: _resource_record_post_action 07:37:15 INFO - [mozharness: 2016-10-30 14:37:15.634847Z] Finished read-buildbot-config step (success) 07:37:15 INFO - [mozharness: 2016-10-30 14:37:15.634935Z] Running download-and-extract step. 07:37:15 INFO - Running pre-action listener: _resource_record_pre_action 07:37:15 INFO - Running main action method: download_and_extract 07:37:15 INFO - mkdir: /builds/slave/test/build/tests 07:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:15 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:37:15 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/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 07:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/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 07:37:15 INFO - Downloaded 1361 bytes. 07:37:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:37:15 INFO - Using the following test package requirements: 07:37:15 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:15 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:37:15 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:37:15 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:15 INFO - u'jsshell-linux-x86_64.zip'], 07:37:15 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:37:15 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:15 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:37:15 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:37:15 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:37:15 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:37:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:37:15 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/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:37:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:37:15 INFO - Http code: 200 07:37:15 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 07:37:15 INFO - x-amz-cf-id: z-rb4jA9w5dLfaGq1VNLhe7UIKZ8Qh9U4ubY_vtAyLyEZAnfp9yfSA== 07:37:15 INFO - x-amz-replication-status: PENDING 07:37:15 INFO - x-amz-version-id: Us6q3AkDZPbzGaHShEYihQeht6IVkeid 07:37:16 INFO - Expected file size: 22006176 07:37:16 INFO - Obtained file size: 22006176 07:37:20 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 07:37:20 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/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:37:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:20 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:37:20 INFO - Http code: 200 07:37:20 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 07:37:20 INFO - x-amz-cf-id: M_cHSjmNYsfQtZ2dAtnJB_r7G3NCf8L7uWpz5Oz4SEx9xa_hFKoIQg== 07:37:20 INFO - x-amz-replication-status: PENDING 07:37:20 INFO - x-amz-version-id: Us6q3AkDZPbzGaHShEYihQeht6IVkeid 07:37:20 INFO - Expected file size: 22006176 07:37:20 INFO - Obtained file size: 22006176 07:37:24 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/1477748280/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:24 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:37:24 INFO - Http code: 200 07:37:24 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 07:37:24 INFO - x-amz-cf-id: b3iMhMFzB0QW7IVP5y7G64uKaRcZtwIq2L6Wo8pZggYoT1J_Kqe5Xw== 07:37:24 INFO - x-amz-replication-status: PENDING 07:37:24 INFO - x-amz-version-id: VIPnUgkuJO4tF53yFW25LoHsIOaYrdjk 07:37:25 INFO - Expected file size: 14409038 07:37:25 INFO - Obtained file size: 14409038 07:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:37:25 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/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 07:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/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 07:37:25 INFO - Downloaded 59622969 bytes. 07:37:25 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:37:25 INFO - mkdir: /builds/slave/test/properties 07:37:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:25 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:25 INFO - Contents: 07:37:25 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:37:26 INFO - Running post-action listener: _resource_record_post_action 07:37:26 INFO - Running post-action listener: set_extra_try_arguments 07:37:26 INFO - [mozharness: 2016-10-30 14:37:26.089618Z] Finished download-and-extract step (success) 07:37:26 INFO - [mozharness: 2016-10-30 14:37:26.089845Z] Running populate-webroot step. 07:37:26 INFO - Running pre-action listener: _resource_record_pre_action 07:37:26 INFO - Running main action method: populate_webroot 07:37:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:26 INFO - '--tppagecycles', 07:37:26 INFO - '7'], 07:37:26 INFO - 'tests': ['tsvgm']}}, 07:37:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:26 INFO - 'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:26 INFO - 'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['damp', 'tps']}, 07:37:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:26 INFO - 'tests': ['damp', 'tps']}, 07:37:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['dromaeo_dom']}, 07:37:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['basic_compositor_video']}, 07:37:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['a11yr', 07:37:26 INFO - 'ts_paint', 07:37:26 INFO - 'tpaint', 07:37:26 INFO - 'sessionrestore', 07:37:26 INFO - 'sessionrestore_no_auto_restore', 07:37:26 INFO - 'tabpaint']}, 07:37:26 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:26 INFO - 'ts_paint', 07:37:26 INFO - 'tpaint', 07:37:26 INFO - 'sessionrestore', 07:37:26 INFO - 'sessionrestore_no_auto_restore', 07:37:26 INFO - 'tabpaint']}, 07:37:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:26 INFO - 'ts_paint', 07:37:26 INFO - 'tpaint', 07:37:26 INFO - 'sessionrestore', 07:37:26 INFO - 'sessionrestore_no_auto_restore', 07:37:26 INFO - 'tabpaint']}, 07:37:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:26 INFO - 'ts_paint', 07:37:26 INFO - 'tpaint', 07:37:26 INFO - 'sessionrestore', 07:37:26 INFO - 'sessionrestore_no_auto_restore', 07:37:26 INFO - 'tabpaint']}, 07:37:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['a11yr', 07:37:26 INFO - 'ts_paint', 07:37:26 INFO - 'tpaint', 07:37:26 INFO - 'sessionrestore', 07:37:26 INFO - 'sessionrestore_no_auto_restore', 07:37:26 INFO - 'tabpaint']}, 07:37:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['a11yr', 07:37:26 INFO - 'ts_paint', 07:37:26 INFO - 'tpaint', 07:37:26 INFO - 'sessionrestore', 07:37:26 INFO - 'sessionrestore_no_auto_restore', 07:37:26 INFO - 'tabpaint']}, 07:37:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['tsvgx', 07:37:26 INFO - 'tsvgr_opacity', 07:37:26 INFO - 'tart', 07:37:26 INFO - 'tscrollx', 07:37:26 INFO - 'cart']}, 07:37:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:26 INFO - 'tsvgr_opacity', 07:37:26 INFO - 'tart', 07:37:26 INFO - 'tscrollx', 07:37:26 INFO - 'cart']}, 07:37:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:26 INFO - 'talos_options': ['--disable-e10s'], 07:37:26 INFO - 'tests': ['tp5o']}, 07:37:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:26 INFO - 'tests': ['tp5o']}, 07:37:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:26 INFO - 'talos_options': ['--disable-e10s', 07:37:26 INFO - '--xperf_path', 07:37:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:26 INFO - 'tests': ['tp5n']}, 07:37:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:26 INFO - 'talos_options': ['--xperf_path', 07:37:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:26 INFO - 'tests': ['tp5n']}}, 07:37:26 INFO - 'talos.zip': {'path': '', 07:37:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:26 INFO - Running post-action listener: _resource_record_post_action 07:37:26 INFO - [mozharness: 2016-10-30 14:37:26.107927Z] Finished populate-webroot step (success) 07:37:26 INFO - [mozharness: 2016-10-30 14:37:26.108015Z] Running create-virtualenv step. 07:37:26 INFO - Running pre-action listener: _resource_record_pre_action 07:37:26 INFO - Running main action method: create_virtualenv 07:37:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:26 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 07:37:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:26 INFO - Using real prefix '/usr' 07:37:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:26 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:28 INFO - Installing pip.................done. 07:37:28 INFO - Return code: 0 07:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:37:28 INFO - Reading from file tmpfile_stdout 07:37:28 INFO - Output received: 07:37:28 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) 07:37:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:28 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')]} 07:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:28 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')]} 07:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:28 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 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:28 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 07:37:28 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 07:37:28 INFO - Using env: {'DISPLAY': ':0', 07:37:28 INFO - 'HOME': '/home/cltbld', 07:37:28 INFO - 'LANG': 'en_US.UTF-8', 07:37:28 INFO - 'LANGUAGE': 'en_US:en', 07:37:28 INFO - 'LOGNAME': 'cltbld', 07:37:28 INFO - 'MAIL': '/var/mail/cltbld', 07:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:28 INFO - 'MOZ_NO_REMOTE': '1', 07:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:28 INFO - 'NO_EM_RESTART': '1', 07:37:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:28 INFO - 'PWD': '/builds/slave/test', 07:37:28 INFO - 'SHELL': '/bin/bash', 07:37:28 INFO - 'SHLVL': '1', 07:37:28 INFO - 'TERM': 'linux', 07:37:28 INFO - 'TMOUT': '86400', 07:37:28 INFO - 'USER': 'cltbld', 07:37:28 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:28 INFO - '_': '/tools/buildbot/bin/python'} 07:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:29 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 07:37:29 INFO - Cleaning up... 07:37:29 INFO - Return code: 0 07:37:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:37:29 INFO - Using env: {'DISPLAY': ':0', 07:37:29 INFO - 'HOME': '/home/cltbld', 07:37:29 INFO - 'LANG': 'en_US.UTF-8', 07:37:29 INFO - 'LANGUAGE': 'en_US:en', 07:37:29 INFO - 'LOGNAME': 'cltbld', 07:37:29 INFO - 'MAIL': '/var/mail/cltbld', 07:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:29 INFO - 'MOZ_NO_REMOTE': '1', 07:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:29 INFO - 'NO_EM_RESTART': '1', 07:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:29 INFO - 'PWD': '/builds/slave/test', 07:37:29 INFO - 'SHELL': '/bin/bash', 07:37:29 INFO - 'SHLVL': '1', 07:37:29 INFO - 'TERM': 'linux', 07:37:29 INFO - 'TMOUT': '86400', 07:37:29 INFO - 'USER': 'cltbld', 07:37:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:29 INFO - '_': '/tools/buildbot/bin/python'} 07:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:29 INFO - Downloading/unpacking psutil>=3.1.1 07:37:29 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 07:37:29 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 07:37:29 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 07:37:29 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 07:37:29 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 07:37:29 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 07:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:31 INFO - Installing collected packages: psutil 07:37:31 INFO - Running setup.py install for psutil 07:37:31 INFO - building 'psutil._psutil_linux' extension 07:37:31 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 07:37:31 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 07:37:31 INFO - building 'psutil._psutil_posix' extension 07:37:31 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 07:37:31 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 07:37:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:31 INFO - Successfully installed psutil 07:37:31 INFO - Cleaning up... 07:37:31 INFO - Return code: 0 07:37:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:37:31 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')]} 07:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:31 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')]} 07:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:31 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 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:31 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 07:37:31 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 07:37:31 INFO - Using env: {'DISPLAY': ':0', 07:37:31 INFO - 'HOME': '/home/cltbld', 07:37:31 INFO - 'LANG': 'en_US.UTF-8', 07:37:31 INFO - 'LANGUAGE': 'en_US:en', 07:37:31 INFO - 'LOGNAME': 'cltbld', 07:37:31 INFO - 'MAIL': '/var/mail/cltbld', 07:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:31 INFO - 'MOZ_NO_REMOTE': '1', 07:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:31 INFO - 'NO_EM_RESTART': '1', 07:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:31 INFO - 'PWD': '/builds/slave/test', 07:37:31 INFO - 'SHELL': '/bin/bash', 07:37:31 INFO - 'SHLVL': '1', 07:37:31 INFO - 'TERM': 'linux', 07:37:31 INFO - 'TMOUT': '86400', 07:37:31 INFO - 'USER': 'cltbld', 07:37:31 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:31 INFO - '_': '/tools/buildbot/bin/python'} 07:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:37:34 INFO - Installing collected packages: mozsystemmonitor 07:37:34 INFO - Running setup.py install for mozsystemmonitor 07:37:34 INFO - Successfully installed mozsystemmonitor 07:37:34 INFO - Cleaning up... 07:37:34 INFO - Return code: 0 07:37:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:37:34 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')]} 07:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:34 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')]} 07:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:34 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 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:34 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 07:37:34 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 07:37:34 INFO - Using env: {'DISPLAY': ':0', 07:37:34 INFO - 'HOME': '/home/cltbld', 07:37:34 INFO - 'LANG': 'en_US.UTF-8', 07:37:34 INFO - 'LANGUAGE': 'en_US:en', 07:37:34 INFO - 'LOGNAME': 'cltbld', 07:37:34 INFO - 'MAIL': '/var/mail/cltbld', 07:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:34 INFO - 'MOZ_NO_REMOTE': '1', 07:37:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:34 INFO - 'NO_EM_RESTART': '1', 07:37:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:34 INFO - 'PWD': '/builds/slave/test', 07:37:34 INFO - 'SHELL': '/bin/bash', 07:37:34 INFO - 'SHLVL': '1', 07:37:34 INFO - 'TERM': 'linux', 07:37:34 INFO - 'TMOUT': '86400', 07:37:34 INFO - 'USER': 'cltbld', 07:37:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:34 INFO - '_': '/tools/buildbot/bin/python'} 07:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:34 INFO - Downloading/unpacking jsonschema==2.5.1 07:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37:36 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 07:37:36 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 07:37:36 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 07:37:36 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 07:37:36 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 07:37:36 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 07:37:36 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:36 INFO - warning: no files found matching '*.txt' 07:37:36 INFO - no previously-included directories found matching 'build' 07:37:36 INFO - no previously-included directories found matching 'dist' 07:37:36 INFO - no previously-included directories found matching '.git*' 07:37:36 INFO - Installing collected packages: jsonschema, functools32 07:37:36 INFO - Running setup.py install for functools32 07:37:36 INFO - warning: no files found matching '*.txt' 07:37:36 INFO - no previously-included directories found matching 'build' 07:37:36 INFO - no previously-included directories found matching 'dist' 07:37:36 INFO - no previously-included directories found matching '.git*' 07:37:36 INFO - Successfully installed jsonschema functools32 07:37:36 INFO - Cleaning up... 07:37:36 INFO - Return code: 0 07:37:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 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 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:36 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 07:37:36 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 07:37:36 INFO - Using env: {'DISPLAY': ':0', 07:37:36 INFO - 'HOME': '/home/cltbld', 07:37:36 INFO - 'LANG': 'en_US.UTF-8', 07:37:36 INFO - 'LANGUAGE': 'en_US:en', 07:37:36 INFO - 'LOGNAME': 'cltbld', 07:37:36 INFO - 'MAIL': '/var/mail/cltbld', 07:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:36 INFO - 'MOZ_NO_REMOTE': '1', 07:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:36 INFO - 'NO_EM_RESTART': '1', 07:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:36 INFO - 'PWD': '/builds/slave/test', 07:37:36 INFO - 'SHELL': '/bin/bash', 07:37:36 INFO - 'SHLVL': '1', 07:37:36 INFO - 'TERM': 'linux', 07:37:36 INFO - 'TMOUT': '86400', 07:37:36 INFO - 'USER': 'cltbld', 07:37:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:36 INFO - '_': '/tools/buildbot/bin/python'} 07:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:37:37 INFO - Cleaning up... 07:37:37 INFO - Return code: 0 07:37:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:37 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 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:37 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 07:37:37 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 07:37:37 INFO - Using env: {'DISPLAY': ':0', 07:37:37 INFO - 'HOME': '/home/cltbld', 07:37:37 INFO - 'LANG': 'en_US.UTF-8', 07:37:37 INFO - 'LANGUAGE': 'en_US:en', 07:37:37 INFO - 'LOGNAME': 'cltbld', 07:37:37 INFO - 'MAIL': '/var/mail/cltbld', 07:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:37 INFO - 'MOZ_NO_REMOTE': '1', 07:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:37 INFO - 'NO_EM_RESTART': '1', 07:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:37 INFO - 'PWD': '/builds/slave/test', 07:37:37 INFO - 'SHELL': '/bin/bash', 07:37:37 INFO - 'SHLVL': '1', 07:37:37 INFO - 'TERM': 'linux', 07:37:37 INFO - 'TMOUT': '86400', 07:37:37 INFO - 'USER': 'cltbld', 07:37:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:37 INFO - '_': '/tools/buildbot/bin/python'} 07:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:37 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:37 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 07:37:37 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 07:37:37 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 07:37:37 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 07:37:37 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 07:37:37 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 07:37:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:39 INFO - Downloading docopt-0.6.1.tar.gz 07:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:40 INFO - Running setup.py install for blobuploader 07:37:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:40 INFO - Running setup.py install for requests 07:37:40 INFO - Running setup.py install for docopt 07:37:40 INFO - Successfully installed blobuploader requests docopt 07:37:40 INFO - Cleaning up... 07:37:40 INFO - Return code: 0 07:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:40 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')]} 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 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')]} 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 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 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:40 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 07:37:40 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 07:37:40 INFO - Using env: {'DISPLAY': ':0', 07:37:40 INFO - 'HOME': '/home/cltbld', 07:37:40 INFO - 'LANG': 'en_US.UTF-8', 07:37:40 INFO - 'LANGUAGE': 'en_US:en', 07:37:40 INFO - 'LOGNAME': 'cltbld', 07:37:40 INFO - 'MAIL': '/var/mail/cltbld', 07:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:40 INFO - 'MOZ_NO_REMOTE': '1', 07:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:40 INFO - 'NO_EM_RESTART': '1', 07:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:40 INFO - 'PWD': '/builds/slave/test', 07:37:40 INFO - 'SHELL': '/bin/bash', 07:37:40 INFO - 'SHLVL': '1', 07:37:40 INFO - 'TERM': 'linux', 07:37:40 INFO - 'TMOUT': '86400', 07:37:40 INFO - 'USER': 'cltbld', 07:37:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:40 INFO - '_': '/tools/buildbot/bin/python'} 07:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:40 INFO - Running setup.py (path:/tmp/pip-XDMjEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:40 INFO - Running setup.py (path:/tmp/pip-sQet8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:40 INFO - Running setup.py (path:/tmp/pip-XK5Crf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:41 INFO - Running setup.py (path:/tmp/pip-mfiXZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:41 INFO - Running setup.py (path:/tmp/pip-sYXvoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:41 INFO - Running setup.py (path:/tmp/pip-mPBjH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:41 INFO - Running setup.py (path:/tmp/pip-ZXrCVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:41 INFO - Running setup.py (path:/tmp/pip-vlWeOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:41 INFO - Running setup.py (path:/tmp/pip-I4OtqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:41 INFO - Running setup.py (path:/tmp/pip-U2MyvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:41 INFO - Running setup.py (path:/tmp/pip-GYM6fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:41 INFO - Running setup.py (path:/tmp/pip-J08Xl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:41 INFO - Running setup.py (path:/tmp/pip-QcRksJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:41 INFO - Running setup.py (path:/tmp/pip-w_LDYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:41 INFO - Running setup.py (path:/tmp/pip-kG3JhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:41 INFO - Running setup.py (path:/tmp/pip-IYjpZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:41 INFO - Running setup.py (path:/tmp/pip-EaZqNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:42 INFO - Running setup.py install for manifestparser 07:37:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:42 INFO - Running setup.py install for mozcrash 07:37:42 INFO - Running setup.py install for mozdebug 07:37:42 INFO - Running setup.py install for mozdevice 07:37:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:42 INFO - Running setup.py install for mozfile 07:37:42 INFO - Running setup.py install for mozhttpd 07:37:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:42 INFO - Running setup.py install for mozinfo 07:37:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:42 INFO - Running setup.py install for mozInstall 07:37:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:42 INFO - Running setup.py install for mozleak 07:37:42 INFO - Running setup.py install for mozlog 07:37:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:43 INFO - Running setup.py install for moznetwork 07:37:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:43 INFO - Running setup.py install for mozprocess 07:37:43 INFO - Running setup.py install for mozprofile 07:37:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:43 INFO - Running setup.py install for mozrunner 07:37:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:43 INFO - Running setup.py install for mozscreenshot 07:37:43 INFO - Running setup.py install for moztest 07:37:43 INFO - Running setup.py install for mozversion 07:37:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:43 INFO - Cleaning up... 07:37:43 INFO - Return code: 0 07:37:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:43 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 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:43 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 07:37:43 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 07:37:43 INFO - Using env: {'DISPLAY': ':0', 07:37:43 INFO - 'HOME': '/home/cltbld', 07:37:43 INFO - 'LANG': 'en_US.UTF-8', 07:37:43 INFO - 'LANGUAGE': 'en_US:en', 07:37:43 INFO - 'LOGNAME': 'cltbld', 07:37:43 INFO - 'MAIL': '/var/mail/cltbld', 07:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:43 INFO - 'MOZ_NO_REMOTE': '1', 07:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:43 INFO - 'NO_EM_RESTART': '1', 07:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:43 INFO - 'PWD': '/builds/slave/test', 07:37:43 INFO - 'SHELL': '/bin/bash', 07:37:43 INFO - 'SHLVL': '1', 07:37:43 INFO - 'TERM': 'linux', 07:37:43 INFO - 'TMOUT': '86400', 07:37:43 INFO - 'USER': 'cltbld', 07:37:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:43 INFO - '_': '/tools/buildbot/bin/python'} 07:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:44 INFO - Running setup.py (path:/tmp/pip-aaRdk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:44 INFO - Running setup.py (path:/tmp/pip-AGwmY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:44 INFO - Running setup.py (path:/tmp/pip-ZO1AWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:44 INFO - Running setup.py (path:/tmp/pip-3Az9Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:44 INFO - Running setup.py (path:/tmp/pip-8kpLIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:44 INFO - Running setup.py (path:/tmp/pip-rlkG3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:44 INFO - Running setup.py (path:/tmp/pip-iK_CYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:44 INFO - Running setup.py (path:/tmp/pip-sqsggU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:44 INFO - Running setup.py (path:/tmp/pip-3Rv8OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:44 INFO - Running setup.py (path:/tmp/pip-LbVxK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:44 INFO - Running setup.py (path:/tmp/pip-ypmymO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:44 INFO - Running setup.py (path:/tmp/pip-7FoVEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:44 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)) 07:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:44 INFO - Running setup.py (path:/tmp/pip-jzuW4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:45 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)) 07:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:45 INFO - Running setup.py (path:/tmp/pip-oTgdZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:45 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)) 07:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:45 INFO - Running setup.py (path:/tmp/pip-x7to9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:45 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)) 07:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:45 INFO - Running setup.py (path:/tmp/pip-VhTX_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:45 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)) 07:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:45 INFO - Running setup.py (path:/tmp/pip-pcKpRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:45 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)) 07:37:45 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)) 07:37:45 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)) 07:37:45 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)) 07:37:45 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)) 07:37:45 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)) 07:37:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:45 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 07:37:45 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 07:37:45 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 07:37:45 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 07:37:45 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 07:37:45 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 07:37:47 INFO - Downloading blessings-1.6.tar.gz 07:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:47 INFO - Installing collected packages: blessings 07:37:47 INFO - Running setup.py install for blessings 07:37:47 INFO - Successfully installed blessings 07:37:47 INFO - Cleaning up... 07:37:47 INFO - Return code: 0 07:37:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:47 INFO - Reading from file tmpfile_stdout 07:37:47 INFO - Current package versions: 07:37:47 INFO - argparse == 1.2.1 07:37:47 INFO - blessings == 1.6 07:37:47 INFO - blobuploader == 1.2.4 07:37:47 INFO - docopt == 0.6.1 07:37:47 INFO - functools32 == 3.2.3-2 07:37:47 INFO - jsonschema == 2.5.1 07:37:47 INFO - manifestparser == 1.1 07:37:47 INFO - mozInstall == 1.12 07:37:47 INFO - mozcrash == 0.17 07:37:47 INFO - mozdebug == 0.1 07:37:47 INFO - mozdevice == 0.48 07:37:47 INFO - mozfile == 1.2 07:37:47 INFO - mozhttpd == 0.7 07:37:47 INFO - mozinfo == 0.9 07:37:47 INFO - mozleak == 0.1 07:37:47 INFO - mozlog == 3.4 07:37:47 INFO - moznetwork == 0.27 07:37:47 INFO - mozprocess == 0.23 07:37:47 INFO - mozprofile == 0.28 07:37:47 INFO - mozrunner == 6.12 07:37:47 INFO - mozscreenshot == 0.1 07:37:47 INFO - mozsystemmonitor == 0.3 07:37:47 INFO - moztest == 0.7 07:37:47 INFO - mozversion == 1.4 07:37:47 INFO - psutil == 3.1.1 07:37:47 INFO - requests == 1.2.3 07:37:47 INFO - wsgiref == 0.1.2 07:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:47 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 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:47 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 07:37:47 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 07:37:47 INFO - Using env: {'DISPLAY': ':0', 07:37:47 INFO - 'HOME': '/home/cltbld', 07:37:47 INFO - 'LANG': 'en_US.UTF-8', 07:37:47 INFO - 'LANGUAGE': 'en_US:en', 07:37:47 INFO - 'LOGNAME': 'cltbld', 07:37:47 INFO - 'MAIL': '/var/mail/cltbld', 07:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:47 INFO - 'MOZ_NO_REMOTE': '1', 07:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:47 INFO - 'NO_EM_RESTART': '1', 07:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:47 INFO - 'PWD': '/builds/slave/test', 07:37:47 INFO - 'SHELL': '/bin/bash', 07:37:47 INFO - 'SHLVL': '1', 07:37:47 INFO - 'TERM': 'linux', 07:37:47 INFO - 'TMOUT': '86400', 07:37:47 INFO - 'USER': 'cltbld', 07:37:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:47 INFO - '_': '/tools/buildbot/bin/python'} 07:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:47 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)) 07:37:47 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)) 07:37:47 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)) 07:37:47 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)) 07:37:47 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)) 07:37:47 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)) 07:37:47 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)) 07:37:47 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)) 07:37:47 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)) 07:37:47 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)) 07:37:47 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)) 07:37:47 INFO - Cleaning up... 07:37:47 INFO - Return code: 0 07:37:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64d8a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', '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 07:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:37:47 INFO - Using env: {'DISPLAY': ':0', 07:37:47 INFO - 'HOME': '/home/cltbld', 07:37:47 INFO - 'LANG': 'en_US.UTF-8', 07:37:47 INFO - 'LANGUAGE': 'en_US:en', 07:37:47 INFO - 'LOGNAME': 'cltbld', 07:37:47 INFO - 'MAIL': '/var/mail/cltbld', 07:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:47 INFO - 'MOZ_NO_REMOTE': '1', 07:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:47 INFO - 'NO_EM_RESTART': '1', 07:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:47 INFO - 'PWD': '/builds/slave/test', 07:37:47 INFO - 'SHELL': '/bin/bash', 07:37:47 INFO - 'SHLVL': '1', 07:37:47 INFO - 'TERM': 'linux', 07:37:47 INFO - 'TMOUT': '86400', 07:37:47 INFO - 'USER': 'cltbld', 07:37:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:47 INFO - '_': '/tools/buildbot/bin/python'} 07:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:37:48 INFO - Cleaning up... 07:37:48 INFO - Return code: 0 07:37:48 INFO - Running post-action listener: _resource_record_post_action 07:37:48 INFO - Running post-action listener: _start_resource_monitoring 07:37:48 INFO - Starting resource monitoring. 07:37:48 INFO - [mozharness: 2016-10-30 14:37:48.227494Z] Finished create-virtualenv step (success) 07:37:48 INFO - [mozharness: 2016-10-30 14:37:48.228010Z] Running install step. 07:37:48 INFO - Running pre-action listener: _resource_record_pre_action 07:37:48 INFO - Running main action method: install 07:37:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:48 INFO - Reading from file tmpfile_stdout 07:37:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:48 INFO - Reading from file tmpfile_stdout 07:37:48 INFO - Output received: 07:37:48 INFO - Usage: mozinstall [options] installer 07:37:48 INFO - Options: 07:37:48 INFO - -h, --help show this help message and exit 07:37:48 INFO - -d DEST, --destination=DEST 07:37:48 INFO - Directory to install application into. [default: 07:37:48 INFO - "/builds/slave/test"] 07:37:48 INFO - --app=APP Application being installed. [default: firefox] 07:37:48 INFO - mkdir: /builds/slave/test/build/application 07:37:48 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'] 07:37:48 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 07:38:05 INFO - Reading from file tmpfile_stdout 07:38:05 INFO - Output received: 07:38:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:05 INFO - Running post-action listener: _resource_record_post_action 07:38:05 INFO - [mozharness: 2016-10-30 14:38:05.477819Z] Finished install step (success) 07:38:05 INFO - [mozharness: 2016-10-30 14:38:05.478096Z] Running run-tests step. 07:38:05 INFO - Running pre-action listener: _resource_record_pre_action 07:38:05 INFO - Running main action method: run_tests 07:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:05 INFO - Python 2.7.3 07:38:05 INFO - Return code: 0 07:38:05 INFO - grabbing minidump binary from tooltool 07:38: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')]} 07:38:05 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 0x188cf60>, '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 0x188dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:05 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 07:38:05 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 07:38:05 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 07:38:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:05 INFO - Return code: 0 07:38:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:05 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:38:05 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:38:05 INFO - Using env: {'DISPLAY': ':0', 07:38:05 INFO - 'HOME': '/home/cltbld', 07:38:05 INFO - 'LANG': 'en_US.UTF-8', 07:38:05 INFO - 'LANGUAGE': 'en_US:en', 07:38:05 INFO - 'LOGNAME': 'cltbld', 07:38:05 INFO - 'MAIL': '/var/mail/cltbld', 07:38:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:05 INFO - 'MOZ_NO_REMOTE': '1', 07:38:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:05 INFO - 'NO_EM_RESTART': '1', 07:38:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:05 INFO - 'PWD': '/builds/slave/test', 07:38:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:05 INFO - 'SHELL': '/bin/bash', 07:38:05 INFO - 'SHLVL': '1', 07:38:05 INFO - 'TERM': 'linux', 07:38:05 INFO - 'TMOUT': '86400', 07:38:05 INFO - 'USER': 'cltbld', 07:38:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091', 07:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:05 INFO - '_': '/tools/buildbot/bin/python'} 07:38:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:38:05 INFO - mozversion application_buildid: 20161029063800 07:38:05 INFO - mozversion application_changeset: a3b6b6e39c7965561fc750d022bee96055731226 07:38:05 INFO - mozversion application_display_name: Nightly 07:38:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:05 INFO - mozversion application_name: Firefox 07:38:05 INFO - mozversion application_remotingname: firefox 07:38:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:38:05 INFO - mozversion application_vendor: Mozilla 07:38:05 INFO - mozversion application_version: 52.0a1 07:38:05 INFO - mozversion platform_buildid: 20161029063800 07:38:05 INFO - mozversion platform_changeset: a3b6b6e39c7965561fc750d022bee96055731226 07:38:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:38:05 INFO - mozversion platform_version: 52.0a1 07:38:05 INFO - using testdate: 1477838285 07:38:05 INFO - actual date: 1477838285 07:38:05 INFO - starting webserver on 'localhost:56120' 07:38:05 INFO - SUITE-START | Running 2 tests 07:38:05 INFO - TEST-START | dromaeo_css 07:38:05 INFO - operating with platform_type : linux_ 07:38:05 INFO - Initialising browser for dromaeo_css test... 07:38:05 INFO - TEST-INFO | started process 19257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8KjTt0/profile http://localhost:56120/getInfo.html) 07:38:10 INFO - PROCESS | 19257 | __metrics Screen width/height:1600/1200 07:38:10 INFO - PROCESS | 19257 | colorDepth:24 07:38:10 INFO - PROCESS | 19257 | Browser inner width/height: 1024/697 07:38:10 INFO - PROCESS | 19257 | __metrics 07:38:11 ERROR - PROCESS | 19257 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 07:38:12 INFO - TEST-INFO | 19257: exit 0 07:38:12 INFO - Browser initialized. 07:38:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:12 INFO - TEST-INFO | started process 19378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8KjTt0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:24 INFO - PROCESS | 19378 | RSS: Main: 185565184 07:38:24 INFO - PROCESS | 19378 | 07:39:13 INFO - PROCESS | 19378 | 1477838353822 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] 07:41:25 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:56120/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56120/tests/dromaeo/cssquery-ext.html) 07:41:26 INFO - PROCESS | 19378 | RSS: Main: 197468160 07:41:26 INFO - PROCESS | 19378 | 07:44:29 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:56120/tests/dromaeo/cssquery-ext.html (next: http://localhost:56120/tests/dromaeo/cssquery-jquery.html) 07:44:29 INFO - PROCESS | 19378 | RSS: Main: 195911680 07:44:29 INFO - PROCESS | 19378 | 07:47:31 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:56120/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56120/tests/dromaeo/cssquery-mootools.html) 07:47:32 INFO - PROCESS | 19378 | RSS: Main: 198295552 07:47:32 INFO - PROCESS | 19378 | 07:50:34 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:56120/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56120/tests/dromaeo/cssquery-prototype.html) 07:50:34 INFO - PROCESS | 19378 | RSS: Main: 194543616 07:50:34 INFO - PROCESS | 19378 | 07:53:37 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:56120/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56120/tests/dromaeo/cssquery-yui.html) 07:53:37 INFO - PROCESS | 19378 | RSS: Main: 198262784 07:53:37 INFO - PROCESS | 19378 | 07:56:40 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:56120/tests/dromaeo/cssquery-yui.html (next: http://localhost:56120/tests/dromaeo/cssquery-dojo.html) 07:56:40 INFO - PROCESS | 19378 | RSS: Main: 197816320 07:56:40 INFO - PROCESS | 19378 | 07:56:40 INFO - PROCESS | 19378 | __start_tp_report 07:56:40 INFO - PROCESS | 19378 | _x_x_mozilla_page_load 07:56:40 INFO - PROCESS | 19378 | _x_x_mozilla_page_load_details 07:56:40 INFO - PROCESS | 19378 | |i|pagename|runs| 07:56:40 INFO - PROCESS | 19378 | |0;dojo.html;3065.693430656934;3070.616172978379;3100.8139511629297;3118.2983828638557;3130.2330928922415;5433.755481003354;5442.292501974747;5501.504864562188;5522.889542209154;5570.526505247049;5441.809536666217;5447.12845944649;5476.972615136919;5483.479069488402;5505.201745746865;4960.6527543072;5003.449620541746;5013.699178049311;5071.923921141168;5079.339685840854;5042.268871013701;5089.491050894918;5097.974510127444;5112.943067170626;5126.846194614168;4835.323054772335;4852.13192920728;5039.823606173766;5096.031753966735;5098.566621837148;4925.187344088221;4952.083864485082;4966.1309270877455;4967.528084831935;5017.297578339036;4877.170880950247;4947.876303092416;4956.801727930879;4974;5020.146575082244;5391.73041347931;5483.725813709299;5489.6980666063355;5503.889922201573;5507.807226747084;5755.251817263729;5763.682997435139;5792.65244085352;5793.681347525884;5880.617759845596;5918.112283157518;5932.762689492415;5935.7625694972585;5944.197533332988;5949.9702501487645;5461.399246082928;5469;5474.151506516497;5486.3690675572425;5503.9174412383845;5803.506701930299;5862.736176872051;5943.108533719977;5956.583039187302;5978.073398623221;5723.399043100498;5780.132980052942;5781.53747700183;5786.1610066540115;5833.329167145747;5802.709864506758;5835.708214589254;5854.560907931922;5859.824205273849;5872.295324560994;5634.323881134208;5741.85645358861;5790.681512516852;5793.159991801165;5808.157817116579;5848.385919478478;5858.355580886099;5865.3254875689845;5867.031939729897;5928.288605367297;4400.493943196573;4441.511433742286;4473.418455600751;4476.81364438424;4510.120526497301;3871.090293780959;3931.1351502669368;3931.980340098281;3962.623550762673;4001.519817621846;5582.7766889324785;5594.328680558359;5604.6917419542315;5621.494065534122;5686.658800471985;5870.618409803349;5879.206307148565;5886;5905.822825315247;5938.8218353449465;5458.153986132156;5553.527950124285;5557.6109672323355;5565.0817615093865;5585.720713964285;4976.950230497721;4978;4978.427480839678;5016.573591244785;5033.194688849767;5980.8504787381535;6013.51891848651;6027.638341699512;6028.9397106029255;6048.0625503047095;5703.144528320785;5792.1311803229855;5814.186013958134;5834.15404766315;5865.178874957594;5953.136795164591;6045.969770151121;6074.878502430015;6091.360407157362;6104.694765261808;5756.856078598069;5791.652500849962;5798.623089499169;5800.100984347433;5809.738561764646;5769.596128271149;5803.82588522345;5826.73779679907;5943.673097979653;5944.791932282349;5652.63257888236;5721;5727.541796656341;5730.570207234391;5731.369549349485;5618.775248989995;5710.714464276686;5731.627444216113;5749.137629355463;5800.216970708901;5503.449655034465;5503.889922201613;5569.136783798518;5724.398938111438;5726.828195154152;5752.309722833287;5786.247787787561;5800.303963524404;5806.158107074535;5857.384974577779;5534.91697624544;5567.944320556742;5659.518940890071;5665.348484924287;5665.5750818689585 07:56:40 INFO - PROCESS | 19378 | |1;ext.html;550.6582869521292;574.2219292858177;581.20375086132;588.1413136820244;594.5540844366725;41627;42230.36654450182;42476.57523424765;45869.7706511467;45876;44188.55811441885;44292.33561496572;44425;44588.3311750324;44593.55406445934;8865.33509986752;8967.461952282883;8996.865047024266;9010.594523246436;9019.368644194876;8683.305335573139;8841.5579221039;8871.95564022179;8872.733817985438;8890.33322500815;8907.643694252221;8918.28653707705;8931.95534022329;8974.775630609221;8981.910180898205;8871.778205544848;8890.59992300348;8892.421992570462;8898.19916207538;8963.058878817728;8631.784205394915;8691.39160258782;8759.2992560595;8763.386562940597;8764.824703505894;42069;42562.36156457655;42570.57429425697;42614.57385426137;42658.22721523091;3049.130997665655;3158.09994151668;3241.286916878283;3407.369636617234;3592.9281414371826;30036.549451758023;30366;31412.685873141432;31905;32190;3833.9424908626393;3855.730098893079;3881;3909.491766070421;3929.9214015719813;341487;345015;348118;349007;350084;63611.36388636147;63947;64205.678971604844;64240.678796605716;64709.67645161744;66471;66761.99857002149;66790.66604667043;66798.33201667921;67109.3289067103;15656.765148522782;15737.370505179893;15813.68372632541;15845.445409410615;15852.048877067413;11614.88385116138;11616.070714342832;11638.883611163948;11677.474513646906;11709.355985420883;18541.33128018458;19646.901765491082;19755.111020004133;19841.206351746056;19879.503012424517;7316.64642041224;7693.846123077507;7711.344535714415;7820.413468989848;7855.489393189425;915.7298596913927;942.707760594218;984.625842179967;1021.7445638590352;1024.6311327921942;29607.111786646004;29732.40535189284;30328.84835575852;31601.52383237842;32757.017289481355;1073.7369344510646;1078.1428764132534;1140.0765380042192;1153.6135394642888;1211.4245733276623;15300.923495382453;15896.74116806052;15920.601984950468;15938;15972.76040859388;538187;539869;539888;541408;542556;55542.72228638831;55664.72167639217;56160.719196403756;56287.71856140693;56414.71792641093;1372.6980064385818;1374.113696665645;1388.8680575345124;1395.3256590422004;1397.826932862417;28838.567421488275;29700.702992969793;30140.397192055596;30185.69814301829;30377;49446;50030.749846251994;50108.74945625249;50158.49841501538;50673.49326506688;375920;379233;380363;380514;381934;26634;27056.32359191036;27335.179944601692;27571.798434579334;27869;43799;44058.33912491379;44239;44590.99340529619;45627.08745825131;37615.43576846295;38574.42138367871;39612.207755844145;41001.58998409977;41552.376714348706;40218.59234926764;41051.384229237185;41334.37998429966;41564.79217604014;41565.37651935284;40148.1970360597;40325.596744032184;41633.79183104065;41925.79037104795;42021.36967945422;35038.82480587581;36912.44631330586;36994.26011479809;37336;37490.25019499649;28150;28169;28277.57583636288;28665.28336791597;28674.85300587953 07:56:40 INFO - PROCESS | 19378 | |2;jquery.html;383.47846928177654;385.60860726362745;396.8888711160875;398.66113803267217;419.63282128137877;16218;16549.007059576405;18029.36897208598;19793.505162370948;19811.60376792465;11541.134414918894;11804.58683946062;12111.57609483666;12170.634880953585;18440.446786596425;5143.202803565444;5350.2777125088005;5354.785808567653;5361.946380536184;5363.517283444489;4690.624750020007;5241.528262456378;5868.9413105869035;5921.674307913063;5927.73325200367;5866.442687944638;5875.324337701177;5878;5885.293764748236;5904.586678932455;5655.660660360371;5800.709964501758;5830.941690583103;5875.853103672443;5878.382769809151;5093.1087059764395;5261.526462618344;5265.736713164365;5267.157254839208;5267.947320526784;12863.549775757803;13214.273214973173;22234.332970010924;22398.88800556003;22700.65949010766;2190.59473997311;2200.064972386745;2215.3748600529125;2243.4503546631017;2684.5973104034356;9361.29790265726;9665.806683866283;9958.651447199385;10333.328333658288;10361.948190259076;1821.717633766755;1888.8961107139103;1926.9710954335696;1958.6768183249746;1960.9019549022491;70986;73146.99999999946;80573;81795.18204817935;83322.58338708268;10708.250422470508;10813.891861081445;11008.808243638201;11033.282836615594;11208.775824483628;15390.615234619225;15440.613984650248;15452.523182283896;15460.304286307142;15526.990745601499;7670.923290767132;7798.571078590732;7965.522068675898;7998.480288745236;8045.798855028671;7258.346748792634;7328.963355183297;7368.705251789976;7480.0649918760155;7514.361279291322;4537.523560026149;4550.112728018071;4639.280911458729;4750.07373562152;4778.187708089633;1799.5141311845728;1868.7103498957683;1932.1021211229747;1951.268274397101;2008.1565742388232;895.6820328783318;918.5315489100607;933.6358820060182;935.9251259899191;936.9765755856158;18502;20129.194832206842;20151.899240503702;20214.494637634176;20276.695849562268;969.8060387922444;971.0677749360551;1002.4536627538009;1002.9297949143636;1019.1235537437798;10809.83785243222;11046.171537134747;11124.110071194285;11156.832647510293;11233.606823761293;425873;439428;439962;440037;441230;92706.53646731858;93633.53183234176;94666.52666736623;97468;100211;992.0724122944926;1004.467632154959;1016.9288149829589;1040.167865707431;1054.3989925742253;16601.335946562;16689.91655041717;17095.743563846303;17386.913065434594;17436.91281543584;39611.80194099011;40805.79597101996;41488;42032.57967420409;43169.7841510803;52329.738351308;54205.45794542162;55665.44334556765;55917.720411397684;56721.71639141778;11006.614768483065;12042.819357709817;12452.937735311265;12633.431495582905;12652.873471265537;8983.140410173404;12568.37158142071;14552;14712.55862324132;14822.629434263798;12392.132550721724;12415.130940834055;12516.186447880858;12589.370531473207;12761.8085728716;12028.63914082579;12090.758184836079;12165.81751273714;12471.438785254504;12504.874951250371;11919.582814601446;12062.939685301517;12238.510459581517;12750.61748147557;12784.936075319563;12440.875591243972;12494.31281279502;12540.122191446511;12740.617781466572;12829.422675979416;12365;12421.130520863453;12601.810972835598;12602.810957835456;12934.482620695067 07:56:40 INFO - PROCESS | 19378 | |3;mootools.html;1485.7919891215229;1520;1679.0281202271979;1732.9046902420378;1807.1777341309696;7473.588952607604;7769.18423565526;8259.91740082599;8759.605817738202;8826.205641492272;8217.424780265368;8538.18887205716;8538.786530336729;8720.43317184384;8780.868286975701;2348.859068455898;2392.031227352925;2395.018042602533;2395.101836811196;2399.0523743121457;2355.5171189906027;2369.4431808524982;2407.614781634939;2409.662647229389;2418.322869596516;2302.1597117052324;2332.6617640442128;2342.484653376263;2359.1978727232736;2367.4554852383962;2281.498070424504;2286.085565773687;2297.035245197021;2315.351701523576;2327.0924339507606;2288.3478208710603;2303.4011157099108;2307.1694190091553;2308.7114110736156;2315.120254303354;8642.30861531076;8735.694250701195;8747.475151490931;8757.124287571256;8845.336599755045;4961.677490963112;5064.645474816764;5083.186690129562;5154.974225128888;5220.060389129955;3214.180384002088;3308.9503657445157;3341.7827841190247;3366.882159124443;3378.054144839449;1094.2706760216079;1104.3263609198464;1140.988590114105;1144.2447984330302;1151.1481503687294;11866.584669536525;11959.581414650445;11981.400929953468;12041.93979030108;12118.575849845212;4491.214037543416;4683.344331793552;4740.4311482621615;4797.472278049412;4821.710697358169;9702.223822094356;9829.655962041437;9844.753881153028;9864.802703945881;9935.602575896883;5123.564497017721;5127.1540195867265;5137.563307118937;5138.07514647367;5155.690658560498;3991.860284890015;4052.0235240265188;4625.722456652612;4705.835295764632;4812.687175333592;3857.40210267409;3935.665468435215;3955.6835453164254;3962.187751510933;4007.5391329997424;1293.379177994568;1308.9280089595163;1312.875276848698;1314.881660650546;1335.7528857161456;964.3442459127721;975.9902400976041;999.9351339483942;1006.2654262388497;1013.4020927652721;5534.252875861787;5662.065759149694;5717.542596592262;5828.154917536934;5916.1421593868645;437.093031958687;445.11422269683095;447.97312161269775;448.5133630011409;467.4857656577805;3816.160444702161;3923.2153569286256;3935.6064393560414;4012;4061.2283666103936;10101.545430455648;10562.366258024389;10601.257911946244;10643.201759867887;10737.248392612599;10288.794224115625;10506.317089389318;10572.259941803999;10592.828470163598;10596.682099537025;8124.959375203086;8154.306883914934;8233.917660823316;8239.835203295901;8244.876326855101;5897.469227769521;5900.793472228452;5913.5564832636865;5929.52563794904;5933;9538.809223815624;9587.280953928623;9718.076782705632;9748.707538773848;9879.802403952024;9882.752931176778;9883;9903.950480247553;9920.355176913477;9923.55344009507;6500.154979852589;6721.22705888829;7408.703651853865;7519.812004699927;7667.923320766721;7991.120976692676;8234.711785087493;8260.421770476009;8363.790905227175;8367.414281000514;7358.411327093712;7386.815329616803;7403.14863790671;7501.962490187514;7673.34776544;6871.381575658214;7004.649767511706;7407.888881666887;7470.215627359266;7654.923450765644;6634.9004764927595;6842.657867106725;6852.6916288768125;6857.657117144223;6871.312868713088;4943.752812359439;4974.8756281093265;4987.077390682735;5117.078925793393;5321.733913304397;4929.137400954747;4963.602911767122;5007.349044624176;5080.644354895122;5159.535641792257 07:56:40 INFO - PROCESS | 19378 | |4;prototype.html;327.6772379206481;336.9006143187759;339.0540392305468;344.701832914529;345.86856994342145;5461.590380721447;5545.585875601716;5562.3881373048935;5592.7762889484475;5602.15967604859;5420.295361602996;5444.700541470217;5462.153366228241;5471.671699698011;5474.37044739855;4142.875713728593;4248.532661407243;4310.353446982962;4316.84891028814;4319.9352009719805;4289.9356509652225;4294.496926075864;4296.849610263642;4309.37514060461;4319.67602429819;4232.132412855372;4252.0858015526655;4262.97868510657;4270.167317373113;4305.763183024932;4135.296999510076;4258.403823464718;4259.76571288579;4280.3793449949735;4314.892127696801;3768.6985041196913;3796.551224460208;3799.126200973764;3803.562590302123;3806.7906265155407;5350.491703288181;5368.194770784375;5371.516563509303;5385.21914322425;5408.59435542332;4879.585235255007;4909.1409003424615;4910.803567857317;4946.40643122824;4978.5270399312;5720.48515633595;5727.627704199255;5732.283464566929;5732.369439361667;5739.684317362543;4178.895527611834;4182.163567286524;4186.91626167475;4198.433211516437;4212.241796476633;5779.768809247625;5895.526118470382;5913.379095195029;5944;5975.133605627159;4289.313709806416;4299.312110062375;4306.868100290376;4313.094250207491;4313.158934007838;4338.262495375794;4367.475902891673;4370.38814565961;4390.165868484977;4391.209582275157;4680.274557443602;4896.5837903777865;4912.1158191525155;4927.9507204927495;4953.331300274489;5752.482276595127;5761.8559536011935;5777.277840269966;5786.94213057864;5793;1497.9026363286353;1509.7131545006414;1510.765831296151;1516.7421538338508;1519.5336500277285;953.8569214617725;979.7018949891423;997.6807421625156;1001.2290536287019;1018.8318927376899;5486.478784515464;5495.258140151109;5508.55931525477;5511.669299842022;5514.5864060195645;5779.393163717833;5883.352831188566;5892.73306239152;5896.882062358729;5903.822885313448;5135.6148288878485;5405.459454054563;5434.64674796137;5453.945460545423;5477.75350109246;3130.749540036837;3164.3671265746484;3164.4620414529586;3169.2710676544525;3181.840907954593;6056.36408177135;6074.240719910012;6080.331163572004;6098.298695650057;6126.203593532812;5833.7083145842535;5895.378770837968;5963.73163207648;5973.880522389615;5980.252468441445;6032.91407546637;6041.697915104227;6057.697115144225;6100.908486372708;6119.785807496805;5635.380108188178;5909.754293368493;5916.290045194604;5938.970305148447;5954.523638108854;5867.65543640121;5881.64746094739;5894.025501456888;5902.1146827976145;5913.172155898264;6055.788047418319;6060;6066.998945173997;6123.510119190543;6134.877302454015;3956.169204467094;4131.256373852735;4153.3769934510065;4178.561251068594;4238.088810905547;5934.6142500737315;5937.732802023833;5941.376155503783;5946.316173640087;5973.5364835615555;5580.804671836466;5694.829155125353;5774.94225057744;5825.79609713658;5831;5592.720363981866;5638.774449021993;5673.461021202979;5685.545156387562;5706.28671416073;5716.514096301861;5717.399673034438;5720.799772007959;5734.5125664319;5754.5684073695475;5673.319201695823;5751.338596061507;5795.536357091507;5804.490832383526;5825.766969321349;5643.633163844337;5643.88712225745;5664.858378540404;5667;5676.7445464955 07:56:40 INFO - PROCESS | 19378 | |5;yui.html;651.5308977536174;677.2414895317243;691.2534462780197;710.9360157585817;725.9020032295642;14693;15214.619634509143;15338.69322613547;15381.53855384339;15393.307301171446;14089.647758806035;14149.221792801392;14183.078099923498;14271.857281427208;14295.928520357409;644.8420137066402;662;774.206438400641;787.6180052674463;801.4309840013598;801.4269797095076;814.7881550796776;815.7552734179752;816.9468984516017;817.3012074676126;852.1265702654766;852.6802449081595;854.1927878155146;854.4616891358436;858.6565373850448;842.8988521377413;845.0113367360203;846.8687353460224;847.1232274595794;847.8728190771373;623.448248300253;625.0187206086446;625.3027873920546;625.9561830671855;627.4227710506345;12916.935415322958;13016.804747928789;13067.215967042008;13126.934365328209;14306.070105443114;13138.934305328508;13731.725365492734;13732.519361822287;13822.654433639138;13864.584062478141;10787.5684972601;11040.889591104067;11138.721531961684;11155.330680159135;11412.486438110305;3675.7978311192874;3703.333399988001;3758.7932663703486;3784.269796877393;3835.673967712748;63010;63218;63733.36266637321;64469.67765161191;64697;8954.686585969459;8968.192862642263;9118.680846170351;9259.398139121071;9306.255499560019;18891.3388031421;19403;19491.025448727505;20127.899360503103;20285.492862678257;8064.758057258292;8171.959140204261;8195.303399211134;8203.343732501386;8204.384671149688;4362.0839623679385;4403.031333106712;4445.310976798602;4451.287793952952;4466.508684044752;3370.9662903371145;3450.9654903451146;3468.0636228218746;3485.3029394121277;3485.5120283160377;627.5513008199068;649.8927676933253;649.909012738217;660.5376236634376;668.6289109544152;639.5938579002367;654.4894981914019;658.539022684123;661.9966900165565;665.3313420012856;8642.43824151428;8710.259627931697;9008.909910900808;9179.678711245208;9464;556.3518500946352;650.3691419323249;652.9608223506605;652.9738810447529;659.3472462262422;4209.600087991697;4390.407295015196;4471.306947423154;4484.12559550891;4512.638988880882;70791;71945.6402717983;74233;85374;93100;71348.64325678338;82257;83337;84735.576322118;84771.5761421189;44242.363645452795;46194.307085393746;46254.53745462569;61819.38180618226;68546;8532.189442003;8844.159804818531;8854.911450885409;8927.598258078273;8941.329400294873;45830.31254531118;46571.53428465672;46785.29822052604;47613;48786.26820597623;42862.78568607137;46933;51018.48981510138;51739;58588;11169.106471482099;11397.829032564685;11583.594574189863;11596.826047609124;11729.824052639387;11953.103517236415;12716.936415318234;13108;13405;13912.930435347758;12091.75816483683;12126.211796233216;12291.262524248574;12370.81443778362;12406.62780116598;12124.333161676192;12232.327222002876;12303.507859685871;12646.936765316115;13417.463301467831;10805.567777288821;10923.945380273048;10967;11232.213745037769;11236.494357753758;8979.910200898168;9593.856092158483;9730.562124704264;9951.203903687832;10014.599416023277;9498.335116542052;9813;9869.802603947737;9875.259355548505;9893.109620134222 07:56:40 INFO - PROCESS | 19378 | __end_tp_report 07:56:40 INFO - PROCESS | 19378 | __start_cc_report 07:56:40 INFO - PROCESS | 19378 | _x_x_mozilla_cycle_collect,334 07:56:40 INFO - PROCESS | 19378 | __end_cc_report 07:56:40 INFO - PROCESS | 19378 | __startTimestamp1477839400567__endTimestamp 07:56:40 INFO - PROCESS | 19378 | 07:56:40 INFO - PROCESS | 19378 | ------- Summary: start ------- 07:56:40 INFO - PROCESS | 19378 | Number of tests: 6 07:56:40 INFO - PROCESS | 19378 | 07:56:40 INFO - PROCESS | 19378 | [#0] dojo.html Cycles:165 Average:5435.63 Median:5659.52 stddev:625.52 (11.1%) stddev-sans-first:599.18 07:56:40 INFO - PROCESS | 19378 | Values: 3065.7 3070.6 3100.8 3118.3 3130.2 5433.8 5442.3 5501.5 5522.9 5570.5 5441.8 5447.1 5477.0 5483.5 5505.2 4960.7 5003.4 5013.7 5071.9 5079.3 5042.3 5089.5 5098.0 5112.9 5126.8 4835.3 4852.1 5039.8 5096.0 5098.6 4925.2 4952.1 4966.1 4967.5 5017.3 4877.2 4947.9 4956.8 4974.0 5020.1 5391.7 5483.7 5489.7 5503.9 5507.8 5755.3 5763.7 5792.7 5793.7 5880.6 5918.1 5932.8 5935.8 5944.2 5950.0 5461.4 5469.0 5474.2 5486.4 5503.9 5803.5 5862.7 5943.1 5956.6 5978.1 5723.4 5780.1 5781.5 5786.2 5833.3 5802.7 5835.7 5854.6 5859.8 5872.3 5634.3 5741.9 5790.7 5793.2 5808.2 5848.4 5858.4 5865.3 5867.0 5928.3 4400.5 4441.5 4473.4 4476.8 4510.1 3871.1 3931.1 3932.0 3962.6 4001.5 5582.8 5594.3 5604.7 5621.5 5686.7 5870.6 5879.2 5886.0 5905.8 5938.8 5458.2 5553.5 5557.6 5565.1 5585.7 4977.0 4978.0 4978.4 5016.6 5033.2 5980.9 6013.5 6027.6 6028.9 6048.1 5703.1 5792.1 5814.2 5834.2 5865.2 5953.1 6046.0 6074.9 6091.4 6104.7 5756.9 5791.7 5798.6 5800.1 5809.7 5769.6 5803.8 5826.7 5943.7 5944.8 5652.6 5721.0 5727.5 5730.6 5731.4 5618.8 5710.7 5731.6 5749.1 5800.2 5503.4 5503.9 5569.1 5724.4 5726.8 5752.3 5786.2 5800.3 5806.2 5857.4 5534.9 5567.9 5659.5 5665.3 5665.6 07:56:40 INFO - PROCESS | 19378 | 07:56:40 INFO - PROCESS | 19378 | [#1] ext.html Cycles:180 Average:58641.72 Median:41443.38 stddev:114166.77 (275.5%) stddev-sans-first:114403.72 07:56:40 INFO - PROCESS | 19378 | Values: 550.7 574.2 581.2 588.1 594.6 41627.0 42230.4 42476.6 45869.8 45876.0 44188.6 44292.3 44425.0 44588.3 44593.6 8865.3 8967.5 8996.9 9010.6 9019.4 8683.3 8841.6 8872.0 8872.7 8890.3 8907.6 8918.3 8932.0 8974.8 8981.9 8871.8 8890.6 8892.4 8898.2 8963.1 8631.8 8691.4 8759.3 8763.4 8764.8 42069.0 42562.4 42570.6 42614.6 42658.2 3049.1 3158.1 3241.3 3407.4 3592.9 30036.5 30366.0 31412.7 31905.0 32190.0 3833.9 3855.7 3881.0 3909.5 3929.9 341487.0 345015.0 348118.0 349007.0 350084.0 63611.4 63947.0 64205.7 64240.7 64709.7 66471.0 66762.0 66790.7 66798.3 67109.3 15656.8 15737.4 15813.7 15845.4 15852.0 11614.9 11616.1 11638.9 11677.5 11709.4 18541.3 19646.9 19755.1 19841.2 19879.5 7316.6 7693.8 7711.3 7820.4 7855.5 915.7 942.7 984.6 1021.7 1024.6 29607.1 29732.4 30328.8 31601.5 32757.0 1073.7 1078.1 1140.1 1153.6 1211.4 15300.9 15896.7 15920.6 15938.0 15972.8 538187.0 539869.0 539888.0 541408.0 542556.0 55542.7 55664.7 56160.7 56287.7 56414.7 1372.7 1374.1 1388.9 1395.3 1397.8 28838.6 29700.7 30140.4 30185.7 30377.0 49446.0 50030.7 50108.7 50158.5 50673.5 375920.0 379233.0 380363.0 380514.0 381934.0 26634.0 27056.3 27335.2 27571.8 27869.0 43799.0 44058.3 44239.0 44591.0 45627.1 37615.4 38574.4 39612.2 41001.6 41552.4 40218.6 41051.4 41334.4 41564.8 41565.4 40148.2 40325.6 41633.8 41925.8 42021.4 35038.8 36912.4 36994.3 37336.0 37490.3 28150.0 28169.0 28277.6 28665.3 28674.9 07:56:40 INFO - PROCESS | 19378 | 07:56:40 INFO - PROCESS | 19378 | [#2] jquery.html Cycles:180 Average:27402.14 Median:11233.65 stddev:72430.63 (644.8%) stddev-sans-first:72605.40 07:56:40 INFO - PROCESS | 19378 | Values: 383.5 385.6 396.9 398.7 419.6 16218.0 16549.0 18029.4 19793.5 19811.6 11541.1 11804.6 12111.6 12170.6 18440.4 5143.2 5350.3 5354.8 5361.9 5363.5 4690.6 5241.5 5868.9 5921.7 5927.7 5866.4 5875.3 5878.0 5885.3 5904.6 5655.7 5800.7 5830.9 5875.9 5878.4 5093.1 5261.5 5265.7 5267.2 5267.9 12863.5 13214.3 22234.3 22398.9 22700.7 2190.6 2200.1 2215.4 2243.5 2684.6 9361.3 9665.8 9958.7 10333.3 10361.9 1821.7 1888.9 1927.0 1958.7 1960.9 70986.0 73147.0 80573.0 81795.2 83322.6 10708.3 10813.9 11008.8 11033.3 11208.8 15390.6 15440.6 15452.5 15460.3 15527.0 7670.9 7798.6 7965.5 7998.5 8045.8 7258.3 7329.0 7368.7 7480.1 7514.4 4537.5 4550.1 4639.3 4750.1 4778.2 1799.5 1868.7 1932.1 1951.3 2008.2 895.7 918.5 933.6 935.9 937.0 18502.0 20129.2 20151.9 20214.5 20276.7 969.8 971.1 1002.5 1002.9 1019.1 10809.8 11046.2 11124.1 11156.8 11233.6 425873.0 439428.0 439962.0 440037.0 441230.0 92706.5 93633.5 94666.5 97468.0 100211.0 992.1 1004.5 1016.9 1040.2 1054.4 16601.3 16689.9 17095.7 17386.9 17436.9 39611.8 40805.8 41488.0 42032.6 43169.8 52329.7 54205.5 55665.4 55917.7 56721.7 11006.6 12042.8 12452.9 12633.4 12652.9 8983.1 12568.4 14552.0 14712.6 14822.6 12392.1 12415.1 12516.2 12589.4 12761.8 12028.6 12090.8 12165.8 12471.4 12504.9 11919.6 12062.9 12238.5 12750.6 12784.9 12440.9 12494.3 12540.1 12740.6 12829.4 12365.0 12421.1 12601.8 12602.8 12934.5 07:56:40 INFO - PROCESS | 19378 | 07:56:40 INFO - PROCESS | 19378 | [#3] mootools.html Cycles:180 Average:5631.72 Median:4969.24 stddev:3178.57 (64.0%) stddev-sans-first:3172.21 07:56:40 INFO - PROCESS | 19378 | Values: 1485.8 1520.0 1679.0 1732.9 1807.2 7473.6 7769.2 8259.9 8759.6 8826.2 8217.4 8538.2 8538.8 8720.4 8780.9 2348.9 2392.0 2395.0 2395.1 2399.1 2355.5 2369.4 2407.6 2409.7 2418.3 2302.2 2332.7 2342.5 2359.2 2367.5 2281.5 2286.1 2297.0 2315.4 2327.1 2288.3 2303.4 2307.2 2308.7 2315.1 8642.3 8735.7 8747.5 8757.1 8845.3 4961.7 5064.6 5083.2 5155.0 5220.1 3214.2 3309.0 3341.8 3366.9 3378.1 1094.3 1104.3 1141.0 1144.2 1151.1 11866.6 11959.6 11981.4 12041.9 12118.6 4491.2 4683.3 4740.4 4797.5 4821.7 9702.2 9829.7 9844.8 9864.8 9935.6 5123.6 5127.2 5137.6 5138.1 5155.7 3991.9 4052.0 4625.7 4705.8 4812.7 3857.4 3935.7 3955.7 3962.2 4007.5 1293.4 1308.9 1312.9 1314.9 1335.8 964.3 976.0 999.9 1006.3 1013.4 5534.3 5662.1 5717.5 5828.2 5916.1 437.1 445.1 448.0 448.5 467.5 3816.2 3923.2 3935.6 4012.0 4061.2 10101.5 10562.4 10601.3 10643.2 10737.2 10288.8 10506.3 10572.3 10592.8 10596.7 8125.0 8154.3 8233.9 8239.8 8244.9 5897.5 5900.8 5913.6 5929.5 5933.0 9538.8 9587.3 9718.1 9748.7 9879.8 9882.8 9883.0 9904.0 9920.4 9923.6 6500.2 6721.2 7408.7 7519.8 7667.9 7991.1 8234.7 8260.4 8363.8 8367.4 7358.4 7386.8 7403.1 7502.0 7673.3 6871.4 7004.6 7407.9 7470.2 7654.9 6634.9 6842.7 6852.7 6857.7 6871.3 4943.8 4974.9 4987.1 5117.1 5321.7 4929.1 4963.6 5007.3 5080.6 5159.5 07:56:40 INFO - PROCESS | 19378 | 07:56:40 INFO - PROCESS | 19378 | [#4] prototype.html Cycles:180 Average:4851.93 Median:5510.11 stddev:1414.93 (25.7%) stddev-sans-first:1377.54 07:56:40 INFO - PROCESS | 19378 | Values: 327.7 336.9 339.1 344.7 345.9 5461.6 5545.6 5562.4 5592.8 5602.2 5420.3 5444.7 5462.2 5471.7 5474.4 4142.9 4248.5 4310.4 4316.8 4319.9 4289.9 4294.5 4296.8 4309.4 4319.7 4232.1 4252.1 4263.0 4270.2 4305.8 4135.3 4258.4 4259.8 4280.4 4314.9 3768.7 3796.6 3799.1 3803.6 3806.8 5350.5 5368.2 5371.5 5385.2 5408.6 4879.6 4909.1 4910.8 4946.4 4978.5 5720.5 5727.6 5732.3 5732.4 5739.7 4178.9 4182.2 4186.9 4198.4 4212.2 5779.8 5895.5 5913.4 5944.0 5975.1 4289.3 4299.3 4306.9 4313.1 4313.2 4338.3 4367.5 4370.4 4390.2 4391.2 4680.3 4896.6 4912.1 4928.0 4953.3 5752.5 5761.9 5777.3 5786.9 5793.0 1497.9 1509.7 1510.8 1516.7 1519.5 953.9 979.7 997.7 1001.2 1018.8 5486.5 5495.3 5508.6 5511.7 5514.6 5779.4 5883.4 5892.7 5896.9 5903.8 5135.6 5405.5 5434.6 5453.9 5477.8 3130.7 3164.4 3164.5 3169.3 3181.8 6056.4 6074.2 6080.3 6098.3 6126.2 5833.7 5895.4 5963.7 5973.9 5980.3 6032.9 6041.7 6057.7 6100.9 6119.8 5635.4 5909.8 5916.3 5939.0 5954.5 5867.7 5881.6 5894.0 5902.1 5913.2 6055.8 6060.0 6067.0 6123.5 6134.9 3956.2 4131.3 4153.4 4178.6 4238.1 5934.6 5937.7 5941.4 5946.3 5973.5 5580.8 5694.8 5774.9 5825.8 5831.0 5592.7 5638.8 5673.5 5685.5 5706.3 5716.5 5717.4 5720.8 5734.5 5754.6 5673.3 5751.3 5795.5 5804.5 5825.8 5643.6 5643.9 5664.9 5667.0 5676.7 07:56:40 INFO - PROCESS | 19378 | 07:56:40 INFO - PROCESS | 19378 | [#5] yui.html Cycles:180 Average:16653.01 Median:31221.42 stddev:22034.79 (70.6%) stddev-sans-first:22063.85 07:56:40 INFO - PROCESS | 19378 | Values: 651.5 677.2 691.3 710.9 725.9 14693.0 15214.6 15338.7 15381.5 15393.3 14089.6 14149.2 14183.1 14271.9 14295.9 644.8 662.0 774.2 787.6 801.4 801.4 814.8 815.8 816.9 817.3 852.1 852.7 854.2 854.5 858.7 842.9 845.0 846.9 847.1 847.9 623.4 625.0 625.3 626.0 627.4 12916.9 13016.8 13067.2 13126.9 14306.1 13138.9 13731.7 13732.5 13822.7 13864.6 10787.6 11040.9 11138.7 11155.3 11412.5 3675.8 3703.3 3758.8 3784.3 3835.7 63010.0 63218.0 63733.4 64469.7 64697.0 8954.7 8968.2 9118.7 9259.4 9306.3 18891.3 19403.0 19491.0 20127.9 20285.5 8064.8 8172.0 8195.3 8203.3 8204.4 4362.1 4403.0 4445.3 4451.3 4466.5 3371.0 3451.0 3468.1 3485.3 3485.5 627.6 649.9 649.9 660.5 668.6 639.6 654.5 658.5 662.0 665.3 8642.4 8710.3 9008.9 9179.7 9464.0 556.4 650.4 653.0 653.0 659.3 4209.6 4390.4 4471.3 4484.1 4512.6 70791.0 71945.6 74233.0 85374.0 93100.0 71348.6 82257.0 83337.0 84735.6 84771.6 44242.4 46194.3 46254.5 61819.4 68546.0 8532.2 8844.2 8854.9 8927.6 8941.3 45830.3 46571.5 46785.3 47613.0 48786.3 42862.8 46933.0 51018.5 51739.0 58588.0 11169.1 11397.8 11583.6 11596.8 11729.8 11953.1 12716.9 13108.0 13405.0 13912.9 12091.8 12126.2 12291.3 12370.8 12406.6 12124.3 12232.3 12303.5 12646.9 13417.5 10805.6 10923.9 10967.0 11232.2 11236.5 8979.9 9593.9 9730.6 9951.2 10014.6 9498.3 9813.0 9869.8 9875.3 9893.1 07:56:40 INFO - PROCESS | 19378 | -------- Summary: end -------- 07:56:40 INFO - PROCESS | 19378 | 07:56:41 INFO - TEST-INFO | 19378: exit 0 07:56:41 INFO - TEST-OK | dromaeo_css | took 1115779ms 07:56:41 INFO - TEST-START | kraken 07:56:41 INFO - operating with platform_type : linux_ 07:56:41 INFO - Initialising browser for kraken test... 07:56:41 INFO - TEST-INFO | started process 19736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJjWoEs/profile http://localhost:56120/getInfo.html) 07:56:45 INFO - PROCESS | 19736 | __metrics Screen width/height:1600/1200 07:56:45 INFO - PROCESS | 19736 | colorDepth:24 07:56:45 INFO - PROCESS | 19736 | Browser inner width/height: 1024/697 07:56:45 INFO - PROCESS | 19736 | __metrics 07:56:46 ERROR - PROCESS | 19736 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 07:56:47 INFO - TEST-INFO | 19736: exit 0 07:56:47 INFO - Browser initialized. 07:56:47 INFO - Running cycle 1/1 for kraken test... 07:56:47 INFO - TEST-INFO | started process 19860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJjWoEs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:59 INFO - PROCESS | 19860 | RSS: Main: 185372672 07:56:59 INFO - PROCESS | 19860 | 07:57:02 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56120/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:03 INFO - PROCESS | 19860 | RSS: Main: 197500928 07:57:03 INFO - PROCESS | 19860 | 07:57:05 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56120/tests/kraken/driver.html?testName=audio-dft) 07:57:06 INFO - PROCESS | 19860 | RSS: Main: 195321856 07:57:06 INFO - PROCESS | 19860 | 07:57:09 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56120/tests/kraken/driver.html?testName=audio-fft) 07:57:10 INFO - PROCESS | 19860 | RSS: Main: 192159744 07:57:10 INFO - PROCESS | 19860 | 07:57:12 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56120/tests/kraken/driver.html?testName=audio-oscillator) 07:57:12 INFO - PROCESS | 19860 | RSS: Main: 193105920 07:57:12 INFO - PROCESS | 19860 | 07:57:15 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56120/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:15 INFO - PROCESS | 19860 | RSS: Main: 193421312 07:57:15 INFO - PROCESS | 19860 | 07:57:18 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56120/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:19 INFO - PROCESS | 19860 | RSS: Main: 193499136 07:57:19 INFO - PROCESS | 19860 | 07:57:22 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56120/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:23 INFO - PROCESS | 19860 | RSS: Main: 193896448 07:57:23 INFO - PROCESS | 19860 | 07:57:25 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56120/tests/kraken/driver.html?testName=json-parse-financial) 07:57:26 INFO - PROCESS | 19860 | RSS: Main: 194011136 07:57:26 INFO - PROCESS | 19860 | 07:57:28 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56120/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:28 INFO - PROCESS | 19860 | RSS: Main: 193536000 07:57:28 INFO - PROCESS | 19860 | 07:57:30 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56120/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:31 INFO - PROCESS | 19860 | RSS: Main: 193593344 07:57:31 INFO - PROCESS | 19860 | 07:57:33 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56120/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:33 INFO - PROCESS | 19860 | RSS: Main: 193425408 07:57:33 INFO - PROCESS | 19860 | 07:57:36 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:37 INFO - PROCESS | 19860 | RSS: Main: 193732608 07:57:37 INFO - PROCESS | 19860 | 07:57:40 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:40 INFO - PROCESS | 19860 | RSS: Main: 194314240 07:57:40 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | Cycle 1(1): loaded http://localhost:56120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56120/tests/kraken/driver.html?testName=ai-astar) 07:57:42 INFO - PROCESS | 19860 | RSS: Main: 196296704 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | __start_tp_report 07:57:42 INFO - PROCESS | 19860 | _x_x_mozilla_page_load 07:57:42 INFO - PROCESS | 19860 | _x_x_mozilla_page_load_details 07:57:42 INFO - PROCESS | 19860 | |i|pagename|runs| 07:57:42 INFO - PROCESS | 19860 | |0;ai-astar;105;112;112;115;111;113;112;115;115;117 07:57:42 INFO - PROCESS | 19860 | |1;audio-beat-detection;159;124;126;165;129;124;124;127;153;127 07:57:42 INFO - PROCESS | 19860 | |2;audio-dft;162;166;164;175;162;163;164;164;164;162 07:57:42 INFO - PROCESS | 19860 | |3;audio-fft;75;78;86;126;80;77;76;79;101;76 07:57:42 INFO - PROCESS | 19860 | |4;audio-oscillator;82;95;128;84;83;82;100;83;82;105 07:57:42 INFO - PROCESS | 19860 | |5;imaging-gaussian-blur;117;118;117;118;118;118;117;118;118;119 07:57:42 INFO - PROCESS | 19860 | |6;imaging-darkroom;147;148;147;149;146;147;147;148;148;147 07:57:42 INFO - PROCESS | 19860 | |7;imaging-desaturate;85;85;86;87;87;87;86;85;86;86 07:57:42 INFO - PROCESS | 19860 | |8;json-parse-financial;56;56;57;54;56;56;57;57;56;56 07:57:42 INFO - PROCESS | 19860 | |9;json-stringify-tinderbox;62;63;62;62;61;63;62;62;62;62 07:57:42 INFO - PROCESS | 19860 | |10;stanford-crypto-aes;81;80;81;81;88;79;79;79;82;80 07:57:42 INFO - PROCESS | 19860 | |11;stanford-crypto-ccm;142;131;134;135;129;136;132;141;175;142 07:57:42 INFO - PROCESS | 19860 | |12;stanford-crypto-pbkdf2;170;163;163;166;170;167;161;160;169;164 07:57:42 INFO - PROCESS | 19860 | |13;stanford-crypto-sha256-iterative;63;66;64;65;65;64;64;63;65;62 07:57:42 INFO - PROCESS | 19860 | __end_tp_report 07:57:42 INFO - PROCESS | 19860 | __start_cc_report 07:57:42 INFO - PROCESS | 19860 | _x_x_mozilla_cycle_collect,801 07:57:42 INFO - PROCESS | 19860 | __end_cc_report 07:57:42 INFO - PROCESS | 19860 | __startTimestamp1477839462778__endTimestamp 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | ------- Summary: start ------- 07:57:42 INFO - PROCESS | 19860 | Number of tests: 14 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.30 (2.9%) stddev-sans-first:2.01 07:57:42 INFO - PROCESS | 19860 | Values: 105.0 112.0 112.0 115.0 111.0 113.0 112.0 115.0 115.0 117.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:128.00 stddev:16.34 (12.8%) stddev-sans-first:15.01 07:57:42 INFO - PROCESS | 19860 | Values: 159.0 124.0 126.0 165.0 129.0 124.0 124.0 127.0 153.0 127.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.86 (2.4%) stddev-sans-first:3.98 07:57:42 INFO - PROCESS | 19860 | Values: 162.0 166.0 164.0 175.0 162.0 163.0 164.0 164.0 164.0 162.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#3] audio-fft Cycles:10 Average:85.40 Median:77.50 stddev:16.24 (20.9%) stddev-sans-first:16.78 07:57:42 INFO - PROCESS | 19860 | Values: 75.0 78.0 86.0 126.0 80.0 77.0 76.0 79.0 101.0 76.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:82.50 stddev:15.14 (18.3%) stddev-sans-first:15.58 07:57:42 INFO - PROCESS | 19860 | Values: 82.0 95.0 128.0 84.0 83.0 82.0 100.0 83.0 82.0 105.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 07:57:42 INFO - PROCESS | 19860 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 119.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 07:57:42 INFO - PROCESS | 19860 | Values: 147.0 148.0 147.0 149.0 146.0 147.0 147.0 148.0 148.0 147.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 07:57:42 INFO - PROCESS | 19860 | Values: 85.0 85.0 86.0 87.0 87.0 87.0 86.0 85.0 86.0 86.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 07:57:42 INFO - PROCESS | 19860 | Values: 56.0 56.0 57.0 54.0 56.0 56.0 57.0 57.0 56.0 56.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:57:42 INFO - PROCESS | 19860 | Values: 62.0 63.0 62.0 62.0 61.0 63.0 62.0 62.0 62.0 62.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:2.67 (3.3%) stddev-sans-first:2.83 07:57:42 INFO - PROCESS | 19860 | Values: 81.0 80.0 81.0 81.0 88.0 79.0 79.0 79.0 82.0 80.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:138.50 stddev:13.23 (9.6%) stddev-sans-first:14.01 07:57:42 INFO - PROCESS | 19860 | Values: 142.0 131.0 134.0 135.0 129.0 136.0 132.0 141.0 175.0 142.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.50 stddev:3.65 (2.2%) stddev-sans-first:3.46 07:57:42 INFO - PROCESS | 19860 | Values: 170.0 163.0 163.0 166.0 170.0 167.0 161.0 160.0 169.0 164.0 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:1.20 (1.9%) stddev-sans-first:1.20 07:57:42 INFO - PROCESS | 19860 | Values: 63.0 66.0 64.0 65.0 65.0 64.0 64.0 63.0 65.0 62.0 07:57:42 INFO - PROCESS | 19860 | -------- Summary: end -------- 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | 07:57:42 INFO - PROCESS | 19860 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:57:42 INFO - PROCESS | 19860 | 07:57:43 INFO - TEST-INFO | 19860: exit 0 07:57:43 INFO - TEST-OK | kraken | took 62421ms 07:57:43 INFO - SUITE-END | took 1178s 07:57:44 INFO - Completed test suite (00:19:38) 07:57:44 INFO - javascript benchmark 07:57:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7122.042908514707, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.693430656934, 3070.616172978379, 3100.8139511629297, 3118.2983828638557, 3130.2330928922415, 5433.755481003354, 5442.292501974747, 5501.504864562188, 5522.889542209154, 5570.526505247049, 5441.809536666217, 5447.12845944649, 5476.972615136919, 5483.479069488402, 5505.201745746865, 4960.6527543072, 5003.449620541746, 5013.699178049311, 5071.923921141168, 5079.339685840854, 5042.268871013701, 5089.491050894918, 5097.974510127444, 5112.943067170626, 5126.846194614168, 4835.323054772335, 4852.13192920728, 5039.823606173766, 5096.031753966735, 5098.566621837148, 4925.187344088221, 4952.083864485082, 4966.1309270877455, 4967.528084831935, 5017.297578339036, 4877.170880950247, 4947.876303092416, 4956.801727930879, 4974.0, 5020.146575082244, 5391.73041347931, 5483.725813709299, 5489.6980666063355, 5503.889922201573, 5507.807226747084, 5755.251817263729, 5763.682997435139, 5792.65244085352, 5793.681347525884, 5880.617759845596, 5918.112283157518, 5932.762689492415, 5935.7625694972585, 5944.197533332988, 5949.9702501487645, 5461.399246082928, 5469.0, 5474.151506516497, 5486.3690675572425, 5503.9174412383845, 5803.506701930299, 5862.736176872051, 5943.108533719977, 5956.583039187302, 5978.073398623221, 5723.399043100498, 5780.132980052942, 5781.53747700183, 5786.1610066540115, 5833.329167145747, 5802.709864506758, 5835.708214589254, 5854.560907931922, 5859.824205273849, 5872.295324560994, 5634.323881134208, 5741.85645358861, 5790.681512516852, 5793.159991801165, 5808.157817116579, 5848.385919478478, 5858.355580886099, 5865.3254875689845, 5867.031939729897, 5928.288605367297, 4400.493943196573, 4441.511433742286, 4473.418455600751, 4476.81364438424, 4510.120526497301, 3871.090293780959, 3931.1351502669368, 3931.980340098281, 3962.623550762673, 4001.519817621846, 5582.7766889324785, 5594.328680558359, 5604.6917419542315, 5621.494065534122, 5686.658800471985, 5870.618409803349, 5879.206307148565, 5886.0, 5905.822825315247, 5938.8218353449465, 5458.153986132156, 5553.527950124285, 5557.6109672323355, 5565.0817615093865, 5585.720713964285, 4976.950230497721, 4978.0, 4978.427480839678, 5016.573591244785, 5033.194688849767, 5980.8504787381535, 6013.51891848651, 6027.638341699512, 6028.9397106029255, 6048.0625503047095, 5703.144528320785, 5792.1311803229855, 5814.186013958134, 5834.15404766315, 5865.178874957594, 5953.136795164591, 6045.969770151121, 6074.878502430015, 6091.360407157362, 6104.694765261808, 5756.856078598069, 5791.652500849962, 5798.623089499169, 5800.100984347433, 5809.738561764646, 5769.596128271149, 5803.82588522345, 5826.73779679907, 5943.673097979653, 5944.791932282349, 5652.63257888236, 5721.0, 5727.541796656341, 5730.570207234391, 5731.369549349485, 5618.775248989995, 5710.714464276686, 5731.627444216113, 5749.137629355463, 5800.216970708901, 5503.449655034465, 5503.889922201613, 5569.136783798518, 5724.398938111438, 5726.828195154152, 5752.309722833287, 5786.247787787561, 5800.303963524404, 5806.158107074535, 5857.384974577779, 5534.91697624544, 5567.944320556742, 5659.518940890071, 5665.348484924287, 5665.5750818689585], "value": 5392.132741251773, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.6582869521292, 574.2219292858177, 581.20375086132, 588.1413136820244, 594.5540844366725, 41627.0, 42230.36654450182, 42476.57523424765, 45869.7706511467, 45876.0, 44188.55811441885, 44292.33561496572, 44425.0, 44588.3311750324, 44593.55406445934, 8865.33509986752, 8967.461952282883, 8996.865047024266, 9010.594523246436, 9019.368644194876, 8683.305335573139, 8841.5579221039, 8871.95564022179, 8872.733817985438, 8890.33322500815, 8907.643694252221, 8918.28653707705, 8931.95534022329, 8974.775630609221, 8981.910180898205, 8871.778205544848, 8890.59992300348, 8892.421992570462, 8898.19916207538, 8963.058878817728, 8631.784205394915, 8691.39160258782, 8759.2992560595, 8763.386562940597, 8764.824703505894, 42069.0, 42562.36156457655, 42570.57429425697, 42614.57385426137, 42658.22721523091, 3049.130997665655, 3158.09994151668, 3241.286916878283, 3407.369636617234, 3592.9281414371826, 30036.549451758023, 30366.0, 31412.685873141432, 31905.0, 32190.0, 3833.9424908626393, 3855.730098893079, 3881.0, 3909.491766070421, 3929.9214015719813, 341487.0, 345015.0, 348118.0, 349007.0, 350084.0, 63611.36388636147, 63947.0, 64205.678971604844, 64240.678796605716, 64709.67645161744, 66471.0, 66761.99857002149, 66790.66604667043, 66798.33201667921, 67109.3289067103, 15656.765148522782, 15737.370505179893, 15813.68372632541, 15845.445409410615, 15852.048877067413, 11614.88385116138, 11616.070714342832, 11638.883611163948, 11677.474513646906, 11709.355985420883, 18541.33128018458, 19646.901765491082, 19755.111020004133, 19841.206351746056, 19879.503012424517, 7316.64642041224, 7693.846123077507, 7711.344535714415, 7820.413468989848, 7855.489393189425, 915.7298596913927, 942.707760594218, 984.625842179967, 1021.7445638590352, 1024.6311327921942, 29607.111786646004, 29732.40535189284, 30328.84835575852, 31601.52383237842, 32757.017289481355, 1073.7369344510646, 1078.1428764132534, 1140.0765380042192, 1153.6135394642888, 1211.4245733276623, 15300.923495382453, 15896.74116806052, 15920.601984950468, 15938.0, 15972.76040859388, 538187.0, 539869.0, 539888.0, 541408.0, 542556.0, 55542.72228638831, 55664.72167639217, 56160.719196403756, 56287.71856140693, 56414.71792641093, 1372.6980064385818, 1374.113696665645, 1388.8680575345124, 1395.3256590422004, 1397.826932862417, 28838.567421488275, 29700.702992969793, 30140.397192055596, 30185.69814301829, 30377.0, 49446.0, 50030.749846251994, 50108.74945625249, 50158.49841501538, 50673.49326506688, 375920.0, 379233.0, 380363.0, 380514.0, 381934.0, 26634.0, 27056.32359191036, 27335.179944601692, 27571.798434579334, 27869.0, 43799.0, 44058.33912491379, 44239.0, 44590.99340529619, 45627.08745825131, 37615.43576846295, 38574.42138367871, 39612.207755844145, 41001.58998409977, 41552.376714348706, 40218.59234926764, 41051.384229237185, 41334.37998429966, 41564.79217604014, 41565.37651935284, 40148.1970360597, 40325.596744032184, 41633.79183104065, 41925.79037104795, 42021.36967945422, 35038.82480587581, 36912.44631330586, 36994.26011479809, 37336.0, 37490.25019499649, 28150.0, 28169.0, 28277.57583636288, 28665.28336791597, 28674.85300587953], "value": 19788.279768340457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.47846928177654, 385.60860726362745, 396.8888711160875, 398.66113803267217, 419.63282128137877, 16218.0, 16549.007059576405, 18029.36897208598, 19793.505162370948, 19811.60376792465, 11541.134414918894, 11804.58683946062, 12111.57609483666, 12170.634880953585, 18440.446786596425, 5143.202803565444, 5350.2777125088005, 5354.785808567653, 5361.946380536184, 5363.517283444489, 4690.624750020007, 5241.528262456378, 5868.9413105869035, 5921.674307913063, 5927.73325200367, 5866.442687944638, 5875.324337701177, 5878.0, 5885.293764748236, 5904.586678932455, 5655.660660360371, 5800.709964501758, 5830.941690583103, 5875.853103672443, 5878.382769809151, 5093.1087059764395, 5261.526462618344, 5265.736713164365, 5267.157254839208, 5267.947320526784, 12863.549775757803, 13214.273214973173, 22234.332970010924, 22398.88800556003, 22700.65949010766, 2190.59473997311, 2200.064972386745, 2215.3748600529125, 2243.4503546631017, 2684.5973104034356, 9361.29790265726, 9665.806683866283, 9958.651447199385, 10333.328333658288, 10361.948190259076, 1821.717633766755, 1888.8961107139103, 1926.9710954335696, 1958.6768183249746, 1960.9019549022491, 70986.0, 73146.99999999946, 80573.0, 81795.18204817935, 83322.58338708268, 10708.250422470508, 10813.891861081445, 11008.808243638201, 11033.282836615594, 11208.775824483628, 15390.615234619225, 15440.613984650248, 15452.523182283896, 15460.304286307142, 15526.990745601499, 7670.923290767132, 7798.571078590732, 7965.522068675898, 7998.480288745236, 8045.798855028671, 7258.346748792634, 7328.963355183297, 7368.705251789976, 7480.0649918760155, 7514.361279291322, 4537.523560026149, 4550.112728018071, 4639.280911458729, 4750.07373562152, 4778.187708089633, 1799.5141311845728, 1868.7103498957683, 1932.1021211229747, 1951.268274397101, 2008.1565742388232, 895.6820328783318, 918.5315489100607, 933.6358820060182, 935.9251259899191, 936.9765755856158, 18502.0, 20129.194832206842, 20151.899240503702, 20214.494637634176, 20276.695849562268, 969.8060387922444, 971.0677749360551, 1002.4536627538009, 1002.9297949143636, 1019.1235537437798, 10809.83785243222, 11046.171537134747, 11124.110071194285, 11156.832647510293, 11233.606823761293, 425873.0, 439428.0, 439962.0, 440037.0, 441230.0, 92706.53646731858, 93633.53183234176, 94666.52666736623, 97468.0, 100211.0, 992.0724122944926, 1004.467632154959, 1016.9288149829589, 1040.167865707431, 1054.3989925742253, 16601.335946562, 16689.91655041717, 17095.743563846303, 17386.913065434594, 17436.91281543584, 39611.80194099011, 40805.79597101996, 41488.0, 42032.57967420409, 43169.7841510803, 52329.738351308, 54205.45794542162, 55665.44334556765, 55917.720411397684, 56721.71639141778, 11006.614768483065, 12042.819357709817, 12452.937735311265, 12633.431495582905, 12652.873471265537, 8983.140410173404, 12568.37158142071, 14552.0, 14712.55862324132, 14822.629434263798, 12392.132550721724, 12415.130940834055, 12516.186447880858, 12589.370531473207, 12761.8085728716, 12028.63914082579, 12090.758184836079, 12165.81751273714, 12471.438785254504, 12504.874951250371, 11919.582814601446, 12062.939685301517, 12238.510459581517, 12750.61748147557, 12784.936075319563, 12440.875591243972, 12494.31281279502, 12540.122191446511, 12740.617781466572, 12829.422675979416, 12365.0, 12421.130520863453, 12601.810972835598, 12602.810957835456, 12934.482620695067], "value": 9175.656365965922, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.7919891215229, 1520.0, 1679.0281202271979, 1732.9046902420378, 1807.1777341309696, 7473.588952607604, 7769.18423565526, 8259.91740082599, 8759.605817738202, 8826.205641492272, 8217.424780265368, 8538.18887205716, 8538.786530336729, 8720.43317184384, 8780.868286975701, 2348.859068455898, 2392.031227352925, 2395.018042602533, 2395.101836811196, 2399.0523743121457, 2355.5171189906027, 2369.4431808524982, 2407.614781634939, 2409.662647229389, 2418.322869596516, 2302.1597117052324, 2332.6617640442128, 2342.484653376263, 2359.1978727232736, 2367.4554852383962, 2281.498070424504, 2286.085565773687, 2297.035245197021, 2315.351701523576, 2327.0924339507606, 2288.3478208710603, 2303.4011157099108, 2307.1694190091553, 2308.7114110736156, 2315.120254303354, 8642.30861531076, 8735.694250701195, 8747.475151490931, 8757.124287571256, 8845.336599755045, 4961.677490963112, 5064.645474816764, 5083.186690129562, 5154.974225128888, 5220.060389129955, 3214.180384002088, 3308.9503657445157, 3341.7827841190247, 3366.882159124443, 3378.054144839449, 1094.2706760216079, 1104.3263609198464, 1140.988590114105, 1144.2447984330302, 1151.1481503687294, 11866.584669536525, 11959.581414650445, 11981.400929953468, 12041.93979030108, 12118.575849845212, 4491.214037543416, 4683.344331793552, 4740.4311482621615, 4797.472278049412, 4821.710697358169, 9702.223822094356, 9829.655962041437, 9844.753881153028, 9864.802703945881, 9935.602575896883, 5123.564497017721, 5127.1540195867265, 5137.563307118937, 5138.07514647367, 5155.690658560498, 3991.860284890015, 4052.0235240265188, 4625.722456652612, 4705.835295764632, 4812.687175333592, 3857.40210267409, 3935.665468435215, 3955.6835453164254, 3962.187751510933, 4007.5391329997424, 1293.379177994568, 1308.9280089595163, 1312.875276848698, 1314.881660650546, 1335.7528857161456, 964.3442459127721, 975.9902400976041, 999.9351339483942, 1006.2654262388497, 1013.4020927652721, 5534.252875861787, 5662.065759149694, 5717.542596592262, 5828.154917536934, 5916.1421593868645, 437.093031958687, 445.11422269683095, 447.97312161269775, 448.5133630011409, 467.4857656577805, 3816.160444702161, 3923.2153569286256, 3935.6064393560414, 4012.0, 4061.2283666103936, 10101.545430455648, 10562.366258024389, 10601.257911946244, 10643.201759867887, 10737.248392612599, 10288.794224115625, 10506.317089389318, 10572.259941803999, 10592.828470163598, 10596.682099537025, 8124.959375203086, 8154.306883914934, 8233.917660823316, 8239.835203295901, 8244.876326855101, 5897.469227769521, 5900.793472228452, 5913.5564832636865, 5929.52563794904, 5933.0, 9538.809223815624, 9587.280953928623, 9718.076782705632, 9748.707538773848, 9879.802403952024, 9882.752931176778, 9883.0, 9903.950480247553, 9920.355176913477, 9923.55344009507, 6500.154979852589, 6721.22705888829, 7408.703651853865, 7519.812004699927, 7667.923320766721, 7991.120976692676, 8234.711785087493, 8260.421770476009, 8363.790905227175, 8367.414281000514, 7358.411327093712, 7386.815329616803, 7403.14863790671, 7501.962490187514, 7673.34776544, 6871.381575658214, 7004.649767511706, 7407.888881666887, 7470.215627359266, 7654.923450765644, 6634.9004764927595, 6842.657867106725, 6852.6916288768125, 6857.657117144223, 6871.312868713088, 4943.752812359439, 4974.8756281093265, 4987.077390682735, 5117.078925793393, 5321.733913304397, 4929.137400954747, 4963.602911767122, 5007.349044624176, 5080.644354895122, 5159.535641792257], "value": 4471.470635958724, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.6772379206481, 336.9006143187759, 339.0540392305468, 344.701832914529, 345.86856994342145, 5461.590380721447, 5545.585875601716, 5562.3881373048935, 5592.7762889484475, 5602.15967604859, 5420.295361602996, 5444.700541470217, 5462.153366228241, 5471.671699698011, 5474.37044739855, 4142.875713728593, 4248.532661407243, 4310.353446982962, 4316.84891028814, 4319.9352009719805, 4289.9356509652225, 4294.496926075864, 4296.849610263642, 4309.37514060461, 4319.67602429819, 4232.132412855372, 4252.0858015526655, 4262.97868510657, 4270.167317373113, 4305.763183024932, 4135.296999510076, 4258.403823464718, 4259.76571288579, 4280.3793449949735, 4314.892127696801, 3768.6985041196913, 3796.551224460208, 3799.126200973764, 3803.562590302123, 3806.7906265155407, 5350.491703288181, 5368.194770784375, 5371.516563509303, 5385.21914322425, 5408.59435542332, 4879.585235255007, 4909.1409003424615, 4910.803567857317, 4946.40643122824, 4978.5270399312, 5720.48515633595, 5727.627704199255, 5732.283464566929, 5732.369439361667, 5739.684317362543, 4178.895527611834, 4182.163567286524, 4186.91626167475, 4198.433211516437, 4212.241796476633, 5779.768809247625, 5895.526118470382, 5913.379095195029, 5944.0, 5975.133605627159, 4289.313709806416, 4299.312110062375, 4306.868100290376, 4313.094250207491, 4313.158934007838, 4338.262495375794, 4367.475902891673, 4370.38814565961, 4390.165868484977, 4391.209582275157, 4680.274557443602, 4896.5837903777865, 4912.1158191525155, 4927.9507204927495, 4953.331300274489, 5752.482276595127, 5761.8559536011935, 5777.277840269966, 5786.94213057864, 5793.0, 1497.9026363286353, 1509.7131545006414, 1510.765831296151, 1516.7421538338508, 1519.5336500277285, 953.8569214617725, 979.7018949891423, 997.6807421625156, 1001.2290536287019, 1018.8318927376899, 5486.478784515464, 5495.258140151109, 5508.55931525477, 5511.669299842022, 5514.5864060195645, 5779.393163717833, 5883.352831188566, 5892.73306239152, 5896.882062358729, 5903.822885313448, 5135.6148288878485, 5405.459454054563, 5434.64674796137, 5453.945460545423, 5477.75350109246, 3130.749540036837, 3164.3671265746484, 3164.4620414529586, 3169.2710676544525, 3181.840907954593, 6056.36408177135, 6074.240719910012, 6080.331163572004, 6098.298695650057, 6126.203593532812, 5833.7083145842535, 5895.378770837968, 5963.73163207648, 5973.880522389615, 5980.252468441445, 6032.91407546637, 6041.697915104227, 6057.697115144225, 6100.908486372708, 6119.785807496805, 5635.380108188178, 5909.754293368493, 5916.290045194604, 5938.970305148447, 5954.523638108854, 5867.65543640121, 5881.64746094739, 5894.025501456888, 5902.1146827976145, 5913.172155898264, 6055.788047418319, 6060.0, 6066.998945173997, 6123.510119190543, 6134.877302454015, 3956.169204467094, 4131.256373852735, 4153.3769934510065, 4178.561251068594, 4238.088810905547, 5934.6142500737315, 5937.732802023833, 5941.376155503783, 5946.316173640087, 5973.5364835615555, 5580.804671836466, 5694.829155125353, 5774.94225057744, 5825.79609713658, 5831.0, 5592.720363981866, 5638.774449021993, 5673.461021202979, 5685.545156387562, 5706.28671416073, 5716.514096301861, 5717.399673034438, 5720.799772007959, 5734.5125664319, 5754.5684073695475, 5673.319201695823, 5751.338596061507, 5795.536357091507, 5804.490832383526, 5825.766969321349, 5643.633163844337, 5643.88712225745, 5664.858378540404, 5667.0, 5676.7445464955], "value": 4400.419659882593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.5308977536174, 677.2414895317243, 691.2534462780197, 710.9360157585817, 725.9020032295642, 14693.0, 15214.619634509143, 15338.69322613547, 15381.53855384339, 15393.307301171446, 14089.647758806035, 14149.221792801392, 14183.078099923498, 14271.857281427208, 14295.928520357409, 644.8420137066402, 662.0, 774.206438400641, 787.6180052674463, 801.4309840013598, 801.4269797095076, 814.7881550796776, 815.7552734179752, 816.9468984516017, 817.3012074676126, 852.1265702654766, 852.6802449081595, 854.1927878155146, 854.4616891358436, 858.6565373850448, 842.8988521377413, 845.0113367360203, 846.8687353460224, 847.1232274595794, 847.8728190771373, 623.448248300253, 625.0187206086446, 625.3027873920546, 625.9561830671855, 627.4227710506345, 12916.935415322958, 13016.804747928789, 13067.215967042008, 13126.934365328209, 14306.070105443114, 13138.934305328508, 13731.725365492734, 13732.519361822287, 13822.654433639138, 13864.584062478141, 10787.5684972601, 11040.889591104067, 11138.721531961684, 11155.330680159135, 11412.486438110305, 3675.7978311192874, 3703.333399988001, 3758.7932663703486, 3784.269796877393, 3835.673967712748, 63010.0, 63218.0, 63733.36266637321, 64469.67765161191, 64697.0, 8954.686585969459, 8968.192862642263, 9118.680846170351, 9259.398139121071, 9306.255499560019, 18891.3388031421, 19403.0, 19491.025448727505, 20127.899360503103, 20285.492862678257, 8064.758057258292, 8171.959140204261, 8195.303399211134, 8203.343732501386, 8204.384671149688, 4362.0839623679385, 4403.031333106712, 4445.310976798602, 4451.287793952952, 4466.508684044752, 3370.9662903371145, 3450.9654903451146, 3468.0636228218746, 3485.3029394121277, 3485.5120283160377, 627.5513008199068, 649.8927676933253, 649.909012738217, 660.5376236634376, 668.6289109544152, 639.5938579002367, 654.4894981914019, 658.539022684123, 661.9966900165565, 665.3313420012856, 8642.43824151428, 8710.259627931697, 9008.909910900808, 9179.678711245208, 9464.0, 556.3518500946352, 650.3691419323249, 652.9608223506605, 652.9738810447529, 659.3472462262422, 4209.600087991697, 4390.407295015196, 4471.306947423154, 4484.12559550891, 4512.638988880882, 70791.0, 71945.6402717983, 74233.0, 85374.0, 93100.0, 71348.64325678338, 82257.0, 83337.0, 84735.576322118, 84771.5761421189, 44242.363645452795, 46194.307085393746, 46254.53745462569, 61819.38180618226, 68546.0, 8532.189442003, 8844.159804818531, 8854.911450885409, 8927.598258078273, 8941.329400294873, 45830.31254531118, 46571.53428465672, 46785.29822052604, 47613.0, 48786.26820597623, 42862.78568607137, 46933.0, 51018.48981510138, 51739.0, 58588.0, 11169.106471482099, 11397.829032564685, 11583.594574189863, 11596.826047609124, 11729.824052639387, 11953.103517236415, 12716.936415318234, 13108.0, 13405.0, 13912.930435347758, 12091.75816483683, 12126.211796233216, 12291.262524248574, 12370.81443778362, 12406.62780116598, 12124.333161676192, 12232.327222002876, 12303.507859685871, 12646.936765316115, 13417.463301467831, 10805.567777288821, 10923.945380273048, 10967.0, 11232.213745037769, 11236.494357753758, 8979.910200898168, 9593.856092158483, 9730.562124704264, 9951.203903687832, 10014.599416023277, 9498.335116542052, 9813.0, 9869.802603947737, 9875.259355548505, 9893.109620134222], "value": 6773.816224235502, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 115.0, 111.0, 113.0, 112.0, 115.0, 115.0, 117.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 126.0, 165.0, 129.0, 124.0, 124.0, 127.0, 153.0, 127.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 175.0, 162.0, 163.0, 164.0, 164.0, 164.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 86.0, 126.0, 80.0, 77.0, 76.0, 79.0, 101.0, 76.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 95.0, 128.0, 84.0, 83.0, 82.0, 100.0, 83.0, 82.0, 105.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 87.0, 87.0, 87.0, 86.0, 85.0, 86.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 54.0, 56.0, 56.0, 57.0, 57.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 81.0, 88.0, 79.0, 79.0, 79.0, 82.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 131.0, 134.0, 135.0, 129.0, 136.0, 132.0, 141.0, 175.0, 142.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 163.0, 163.0, 166.0, 170.0, 167.0, 161.0, 160.0, 169.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 65.0, 65.0, 64.0, 64.0, 63.0, 65.0, 62.0], "value": 64.1, "unit": "score"}]}]} 07:57:44 INFO - Return code: 0 07:57:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:57:44 ERROR - # TBPL SUCCESS # 07:57:44 INFO - Running post-action listener: _resource_record_post_action 07:57:44 INFO - [mozharness: 2016-10-30 14:57:44.617878Z] Finished run-tests step (success) 07:57:44 INFO - Running post-run listener: _resource_record_post_run 07:57:44 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 409067520; Read time: 20; Write time: 346268 07:57:44 INFO - TinderboxPrint: CPU usage
13.3% 07:57:44 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 07:57:44 INFO - TinderboxPrint: I/O write bytes / time
409,067,520 / 346,268 07:57:44 INFO - TinderboxPrint: CPU idle
8,262.4 (86.6%) 07:57:44 INFO - TinderboxPrint: CPU user
1,210.6 (12.7%) 07:57:44 INFO - TinderboxPrint: Swap in / out
0 / 0 07:57:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 119881728; Read time: 0; Write time: 110928 07:57:44 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288567296; Read time: 0; Write time: 235336 07:57:45 INFO - Running post-run listener: _upload_blobber_files 07:57:45 INFO - Blob upload gear active. 07:57:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:45 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 07:57:45 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'] 07:57:45 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 07:57:45 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:57:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:46 INFO - (blobuploader) - INFO - Done attempting. 07:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:57:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:50 INFO - (blobuploader) - INFO - Done attempting. 07:57:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:57:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:57:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:50 INFO - (blobuploader) - INFO - Done attempting. 07:57:50 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:50 INFO - Return code: 0 07:57:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4507054259e8447a4536a462d9a1b0969ecf5338ee4b9482e0d7e70dfea341a0a0e43c8f90f490dcc730734ec106da3468070ddfeb5d169bb82c2b62d1148b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/31c3d045e3513d0053a18b9fdc5742ee79f8a10fc5699bf17c02e892692219d786941552cc153332a0f7852bfe53c0247f844dfd7c25515d1cc03f3fd8781ef4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bed7ac6e3e1c2ed2570b108e34c3fc1f0adc0fa9221539ced0e1897dc7d1d133d87e22ff0ba24d5b0bccb2613fc1eaa2595390252ab0e131c9b82e8a786eec98"} 07:57:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:50 INFO - Contents: 07:57:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4507054259e8447a4536a462d9a1b0969ecf5338ee4b9482e0d7e70dfea341a0a0e43c8f90f490dcc730734ec106da3468070ddfeb5d169bb82c2b62d1148b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/31c3d045e3513d0053a18b9fdc5742ee79f8a10fc5699bf17c02e892692219d786941552cc153332a0f7852bfe53c0247f844dfd7c25515d1cc03f3fd8781ef4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bed7ac6e3e1c2ed2570b108e34c3fc1f0adc0fa9221539ced0e1897dc7d1d133d87e22ff0ba24d5b0bccb2613fc1eaa2595390252ab0e131c9b82e8a786eec98"} 07:57:50 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:50 INFO - Copying logs to upload dir... 07:57:50 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.415515 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-30 07:57:50.546099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 07:57:50.549877) ========= 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=db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4507054259e8447a4536a462d9a1b0969ecf5338ee4b9482e0d7e70dfea341a0a0e43c8f90f490dcc730734ec106da3468070ddfeb5d169bb82c2b62d1148b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/31c3d045e3513d0053a18b9fdc5742ee79f8a10fc5699bf17c02e892692219d786941552cc153332a0f7852bfe53c0247f844dfd7c25515d1cc03f3fd8781ef4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bed7ac6e3e1c2ed2570b108e34c3fc1f0adc0fa9221539ced0e1897dc7d1d133d87e22ff0ba24d5b0bccb2613fc1eaa2595390252ab0e131c9b82e8a786eec98"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4507054259e8447a4536a462d9a1b0969ecf5338ee4b9482e0d7e70dfea341a0a0e43c8f90f490dcc730734ec106da3468070ddfeb5d169bb82c2b62d1148b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/31c3d045e3513d0053a18b9fdc5742ee79f8a10fc5699bf17c02e892692219d786941552cc153332a0f7852bfe53c0247f844dfd7c25515d1cc03f3fd8781ef4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bed7ac6e3e1c2ed2570b108e34c3fc1f0adc0fa9221539ced0e1897dc7d1d133d87e22ff0ba24d5b0bccb2613fc1eaa2595390252ab0e131c9b82e8a786eec98"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 07:57:50.574801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:57:50.575113) ========= 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=db0483c52d987ecb441a263b000001ad-1477838232.540414-1712283091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:57:50.660289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 07:57:50.660682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 07:57:50.660964) ========= ========= Total master_lag: 0.19 =========